builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0094 starttime: 1476278598.86 results: success (0) buildid: 20161012030748 builduid: df22735bda3c4d47b86a6bb5d0e641b0 revision: aa8629a25ab5aeb2678a0187e50336659d368b44 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-12 06:23:18.857998) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-12 06:23:18.858452) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-12 06:23:18.858735) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-12 06:23:18.885860) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 06:23:18.886262) ========= 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.3Y1PZSM4Ar/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.K9zhye8C5Z/Listeners TMPDIR=/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-12 06:23:18-- 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% 14.3M=0.001s 2016-10-12 06:23:19 (14.3 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.117910 ========= master_lag: 0.52 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 06:23:19.522772) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 06:23:19.523138) ========= 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.3Y1PZSM4Ar/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.K9zhye8C5Z/Listeners TMPDIR=/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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.028649 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 06:23:19.572893) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-12 06:23:19.573259) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev aa8629a25ab5aeb2678a0187e50336659d368b44 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev aa8629a25ab5aeb2678a0187e50336659d368b44 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.3Y1PZSM4Ar/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.K9zhye8C5Z/Listeners TMPDIR=/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-12 06:23:19,649 truncating revision to first 12 chars 2016-10-12 06:23:19,649 Setting DEBUG logging. 2016-10-12 06:23:19,649 attempt 1/10 2016-10-12 06:23:19,649 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/aa8629a25ab5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-12 06:23:20,626 unpacking tar archive at: fx-team-aa8629a25ab5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.245150 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-12 06:23:20.840783) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-12 06:23:20.841110) ========= script_repo_revision: aa8629a25ab5aeb2678a0187e50336659d368b44 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-12 06:23:20.841533) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-12 06:23:20.841817) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-12 06:23:20.860680) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-10-12 06:23:20.861121) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.3Y1PZSM4Ar/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.K9zhye8C5Z/Listeners TMPDIR=/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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 06:23:21 INFO - MultiFileLogger online at 20161012 06:23:21 in /builds/slave/test 06:23:21 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 06:23:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:23:21 INFO - {'append_to_log': False, 06:23:21 INFO - 'base_work_dir': '/builds/slave/test', 06:23:21 INFO - 'blob_upload_branch': 'Fx-Team', 06:23:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:23:21 INFO - 'branch': 'Fx-Team', 06:23:21 INFO - 'buildbot_json_path': 'buildprops.json', 06:23:21 INFO - 'config_files': ('talos/mac_config.py',), 06:23:21 INFO - 'default_actions': ('clobber', 06:23:21 INFO - 'read-buildbot-config', 06:23:21 INFO - 'download-and-extract', 06:23:21 INFO - 'populate-webroot', 06:23:21 INFO - 'create-virtualenv', 06:23:21 INFO - 'install', 06:23:21 INFO - 'run-tests'), 06:23:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:23:21 INFO - 'download_minidump_stackwalk': True, 06:23:21 INFO - 'download_symbols': 'ondemand', 06:23:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:23:21 INFO - 'tooltool.py': '/tools/tooltool.py', 06:23:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:23:21 INFO - '/tools/misc-python/virtualenv.py')}, 06:23:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:23:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:23:21 INFO - 'installer_path': 'installer.exe', 06:23:21 INFO - 'log_level': 'info', 06:23:21 INFO - 'log_name': 'talos', 06:23:21 INFO - 'log_to_console': True, 06:23:21 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:23:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:23:21 INFO - 'opt_config_files': (), 06:23:21 INFO - 'pip_index': False, 06:23:21 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:23:21 INFO - 'cmd': ('bash', 06:23:21 INFO - '-c', 06:23:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:23:21 INFO - 'enabled': True, 06:23:21 INFO - 'halt_on_failure': False, 06:23:21 INFO - 'name': 'check_screen_resolution'},), 06:23:21 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:23:21 INFO - 'cmd': ('bash', 06:23:21 INFO - '-c', 06:23:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:23:21 INFO - 'enabled': True, 06:23:21 INFO - 'halt_on_failure': False, 06:23:21 INFO - 'name': 'check_screen_resolution'},), 06:23:21 INFO - 'run_cmd_checks_enabled': True, 06:23:21 INFO - 'sps_profile': False, 06:23:21 INFO - 'sps_profile_interval': 0, 06:23:21 INFO - 'suite': 'dromaeojs-e10s', 06:23:21 INFO - 'system_bits': '32', 06:23:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:23:21 INFO - 'title': 't-yosemite-r7-0094', 06:23:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:23:21 INFO - 'use_talos_json': True, 06:23:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:23:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:23:21 INFO - 'work_dir': 'build'} 06:23:21 INFO - [mozharness: 2016-10-12 13:23:21.084804Z] Running clobber step. 06:23:21 INFO - Running pre-action listener: _resource_record_pre_action 06:23:21 INFO - Running main action method: clobber 06:23:21 INFO - rmtree: /builds/slave/test/build 06:23:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:23:23 INFO - Running post-action listener: _resource_record_post_action 06:23:23 INFO - [mozharness: 2016-10-12 13:23:23.369854Z] Finished clobber step (success) 06:23:23 INFO - [mozharness: 2016-10-12 13:23:23.369977Z] Running read-buildbot-config step. 06:23:23 INFO - Running pre-action listener: _resource_record_pre_action 06:23:23 INFO - Running main action method: read_buildbot_config 06:23:23 INFO - Using buildbot properties: 06:23:23 INFO - { 06:23:23 INFO - "project": "", 06:23:23 INFO - "product": "firefox", 06:23:23 INFO - "script_repo_revision": "production", 06:23:23 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 06:23:23 INFO - "repository": "", 06:23:23 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 06:23:23 INFO - "buildid": "20161012030748", 06:23:23 INFO - "pgo_build": "False", 06:23:23 INFO - "basedir": "/builds/slave/test", 06:23:23 INFO - "buildnumber": 108, 06:23:23 INFO - "slavename": "t-yosemite-r7-0094", 06:23:23 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 06:23:23 INFO - "platform": "yosemite_r7", 06:23:23 INFO - "scheduler": "tests-fx-team-macosx64-talos-8-3600", 06:23:23 INFO - "branch": "fx-team", 06:23:23 INFO - "repo_path": "integration/fx-team", 06:23:23 INFO - "revision": "aa8629a25ab5aeb2678a0187e50336659d368b44", 06:23:23 INFO - "stage_platform": "macosx64", 06:23:23 INFO - "builduid": "df22735bda3c4d47b86a6bb5d0e641b0", 06:23:23 INFO - "slavebuilddir": "test" 06:23:23 INFO - } 06:23:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/duYfj-nyRXajoKc14IB9NA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 06:23:23 INFO - Running post-action listener: _resource_record_post_action 06:23:23 INFO - [mozharness: 2016-10-12 13:23:23.373222Z] Finished read-buildbot-config step (success) 06:23:23 INFO - [mozharness: 2016-10-12 13:23:23.373347Z] Running download-and-extract step. 06:23:23 INFO - Running pre-action listener: _resource_record_pre_action 06:23:23 INFO - Running main action method: download_and_extract 06:23:23 INFO - mkdir: /builds/slave/test/build/tests 06:23:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:23:23 INFO - trying https://queue.taskcluster.net/v1/task/duYfj-nyRXajoKc14IB9NA/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 06:23:23 INFO - Downloading https://queue.taskcluster.net/v1/task/duYfj-nyRXajoKc14IB9NA/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 06:23:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/duYfj-nyRXajoKc14IB9NA/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 06:23:24 INFO - Downloaded 1199 bytes. 06:23:24 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 06:23:24 INFO - Using the following test package requirements: 06:23:24 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 06:23:24 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:23:24 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 06:23:24 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:23:24 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 06:23:24 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:23:24 INFO - u'jsshell-mac.zip'], 06:23:24 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:23:24 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 06:23:24 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 06:23:24 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:23:24 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 06:23:24 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:23:24 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 06:23:24 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:23:24 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 06:23:24 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:23:24 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 06:23:24 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 06:23:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/duYfj-nyRXajoKc14IB9NA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 06:23:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/duYfj-nyRXajoKc14IB9NA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:23:24 INFO - Fetch https://queue.taskcluster.net/v1/task/duYfj-nyRXajoKc14IB9NA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 06:23:25 INFO - Http code: 200 06:23:25 INFO - via: 1.1 aa89533ad2ec5e0edba466c9920bd000.cloudfront.net (CloudFront) 06:23:25 INFO - x-amz-cf-id: 2SWM-yPvwi_ytcLMRi_S3JJfxYZysQVBpR22-_J-3S1ftrqFdKFiMg== 06:23:25 INFO - x-amz-version-id: uWOu50AXEx5wjrr.PNg1pUhCoAtXu8Oq 06:23:25 INFO - Expected file size: 16510522 06:23:25 INFO - Obtained file size: 16510522 06:23:32 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 06:23:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/duYfj-nyRXajoKc14IB9NA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 06:23:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/duYfj-nyRXajoKc14IB9NA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:23:32 INFO - Fetch https://queue.taskcluster.net/v1/task/duYfj-nyRXajoKc14IB9NA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 06:23:32 INFO - Http code: 200 06:23:32 INFO - via: 1.1 95da1452a75435200220a7075ca3893f.cloudfront.net (CloudFront) 06:23:32 INFO - x-amz-cf-id: _v5jY7so3YgJa7QIkurXpwzALAGBf2ljHdI3X7gYx2tvxsSkfTNjBA== 06:23:32 INFO - x-amz-version-id: uWOu50AXEx5wjrr.PNg1pUhCoAtXu8Oq 06:23:33 INFO - Expected file size: 16510522 06:23:33 INFO - Obtained file size: 16510522 06:23:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/duYfj-nyRXajoKc14IB9NA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 06:23:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/duYfj-nyRXajoKc14IB9NA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 06:23:39 INFO - Fetch https://queue.taskcluster.net/v1/task/duYfj-nyRXajoKc14IB9NA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 06:23:40 INFO - Http code: 200 06:23:40 INFO - via: 1.1 373880a309382d9266a9313233b86d25.cloudfront.net (CloudFront) 06:23:40 INFO - x-amz-cf-id: uymoelsNX5WtKXIumIKWuO5JHOOOePFCYFkLZv5BDHD_0n0MGf9Xxw== 06:23:40 INFO - x-amz-version-id: CFxJZBpHaXWlOsYARpyHcNlK7N1v7buz 06:23:40 INFO - Expected file size: 14409006 06:23:40 INFO - Obtained file size: 14409006 06:23:40 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')]} 06:23:40 INFO - trying https://queue.taskcluster.net/v1/task/duYfj-nyRXajoKc14IB9NA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 06:23:40 INFO - Downloading https://queue.taskcluster.net/v1/task/duYfj-nyRXajoKc14IB9NA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 06:23:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/duYfj-nyRXajoKc14IB9NA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 06:23:43 INFO - Downloaded 111705988 bytes. 06:23:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/duYfj-nyRXajoKc14IB9NA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 06:23:43 INFO - mkdir: /builds/slave/test/properties 06:23:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:23:43 INFO - Writing to file /builds/slave/test/properties/build_url 06:23:43 INFO - Contents: 06:23:43 INFO - build_url:https://queue.taskcluster.net/v1/task/duYfj-nyRXajoKc14IB9NA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 06:23:44 INFO - Running post-action listener: _resource_record_post_action 06:23:44 INFO - Running post-action listener: set_extra_try_arguments 06:23:44 INFO - [mozharness: 2016-10-12 13:23:44.168446Z] Finished download-and-extract step (success) 06:23:44 INFO - [mozharness: 2016-10-12 13:23:44.168573Z] Running populate-webroot step. 06:23:44 INFO - Running pre-action listener: _resource_record_pre_action 06:23:44 INFO - Running main action method: populate_webroot 06:23:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:23:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:23:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:23:44 INFO - '--tppagecycles', 06:23:44 INFO - '7'], 06:23:44 INFO - 'tests': ['tsvgm']}}, 06:23:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:23:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:23:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:23:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:23:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:23:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:23:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:23:44 INFO - 'talos_options': ['--disable-e10s'], 06:23:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:23:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:23:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:23:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:23:44 INFO - 'talos_options': ['--disable-e10s'], 06:23:44 INFO - 'tests': ['damp', 'tps']}, 06:23:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:23:44 INFO - 'tests': ['damp', 'tps']}, 06:23:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:23:44 INFO - 'tests': ['dromaeo_dom']}, 06:23:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:23:44 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:23:44 INFO - 'tests': ['basic_compositor_video']}, 06:23:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:23:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:23:44 INFO - 'tests': ['a11yr', 06:23:44 INFO - 'ts_paint', 06:23:44 INFO - 'tpaint', 06:23:44 INFO - 'sessionrestore', 06:23:44 INFO - 'sessionrestore_no_auto_restore', 06:23:44 INFO - 'tabpaint']}, 06:23:44 INFO - 'other-e10s': {'tests': ['a11yr', 06:23:44 INFO - 'ts_paint', 06:23:44 INFO - 'tpaint', 06:23:44 INFO - 'sessionrestore', 06:23:44 INFO - 'sessionrestore_no_auto_restore', 06:23:44 INFO - 'tabpaint']}, 06:23:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:23:44 INFO - 'ts_paint', 06:23:44 INFO - 'tpaint', 06:23:44 INFO - 'sessionrestore', 06:23:44 INFO - 'sessionrestore_no_auto_restore', 06:23:44 INFO - 'tabpaint']}, 06:23:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:23:44 INFO - 'ts_paint', 06:23:44 INFO - 'tpaint', 06:23:44 INFO - 'sessionrestore', 06:23:44 INFO - 'sessionrestore_no_auto_restore', 06:23:44 INFO - 'tabpaint']}, 06:23:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:23:44 INFO - 'tests': ['a11yr', 06:23:44 INFO - 'ts_paint', 06:23:44 INFO - 'tpaint', 06:23:44 INFO - 'sessionrestore', 06:23:44 INFO - 'sessionrestore_no_auto_restore', 06:23:44 INFO - 'tabpaint']}, 06:23:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:23:44 INFO - 'tests': ['a11yr', 06:23:44 INFO - 'ts_paint', 06:23:44 INFO - 'tpaint', 06:23:44 INFO - 'sessionrestore', 06:23:44 INFO - 'sessionrestore_no_auto_restore', 06:23:44 INFO - 'tabpaint']}, 06:23:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:23:44 INFO - 'tests': ['tsvgx', 06:23:44 INFO - 'tsvgr_opacity', 06:23:44 INFO - 'tart', 06:23:44 INFO - 'tscrollx', 06:23:44 INFO - 'cart']}, 06:23:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:23:44 INFO - 'tsvgr_opacity', 06:23:44 INFO - 'tart', 06:23:44 INFO - 'tscrollx', 06:23:44 INFO - 'cart']}, 06:23:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:23:44 INFO - 'talos_options': ['--disable-e10s'], 06:23:44 INFO - 'tests': ['tp5o']}, 06:23:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:23:44 INFO - 'tests': ['tp5o']}, 06:23:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:23:44 INFO - 'talos_options': ['--disable-e10s', 06:23:44 INFO - '--xperf_path', 06:23:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:23:44 INFO - 'tests': ['tp5n']}, 06:23:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:23:44 INFO - 'talos_options': ['--xperf_path', 06:23:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:23:44 INFO - 'tests': ['tp5n']}}, 06:23:44 INFO - 'talos.zip': {'path': '', 06:23:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:23:44 INFO - Running post-action listener: _resource_record_post_action 06:23:44 INFO - [mozharness: 2016-10-12 13:23:44.187417Z] Finished populate-webroot step (success) 06:23:44 INFO - [mozharness: 2016-10-12 13:23:44.187547Z] Running create-virtualenv step. 06:23:44 INFO - Running pre-action listener: _resource_record_pre_action 06:23:44 INFO - Running main action method: create_virtualenv 06:23:44 INFO - Creating virtualenv /builds/slave/test/build/venv 06:23:44 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 06:23:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:23:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:23:44 INFO - Using real prefix '/tools/python27' 06:23:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:23:45 INFO - Installing distribute.............................................................................................................................................................................................done. 06:23:47 INFO - Installing pip.................done. 06:23:47 INFO - Return code: 0 06:23:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:23:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:23:48 INFO - Reading from file tmpfile_stdout 06:23:48 INFO - Output received: 06:23:48 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) 06:23:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:23:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:23:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:23:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:23:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:23:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:48 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 0x10ddaf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd25570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2a3595540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dbc3d30>, '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 0x10d9e9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dbbbb20>, '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.3Y1PZSM4Ar/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.K9zhye8C5Z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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 06:23:48 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 06:23:48 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 06:23:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3Y1PZSM4Ar/Render', 06:23:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:23:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:23:48 INFO - 'HOME': '/Users/cltbld', 06:23:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:23:48 INFO - 'LOGNAME': 'cltbld', 06:23:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:23:48 INFO - 'MOZ_NO_REMOTE': '1', 06:23:48 INFO - 'NO_EM_RESTART': '1', 06:23:48 INFO - 'PAGER': '/bin/cat', 06:23:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:23:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:23:48 INFO - 'PWD': '/builds/slave/test', 06:23:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:23:48 INFO - 'SHELL': '/bin/bash', 06:23:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K9zhye8C5Z/Listeners', 06:23:48 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 06:23:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:23:48 INFO - 'USER': 'cltbld', 06:23:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:23:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:23:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:23:48 INFO - 'XPC_FLAGS': '0x0', 06:23:48 INFO - 'XPC_SERVICE_NAME': '0', 06:23:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:23:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:23:48 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 06:23:48 INFO - Cleaning up... 06:23:48 INFO - Return code: 0 06:23:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:23:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:23:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:23:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:23:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:23:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:48 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 0x10ddaf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd25570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2a3595540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dbc3d30>, '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 0x10d9e9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dbbbb20>, '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.3Y1PZSM4Ar/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.K9zhye8C5Z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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 06:23:48 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 06:23:48 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 06:23:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3Y1PZSM4Ar/Render', 06:23:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:23:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:23:48 INFO - 'HOME': '/Users/cltbld', 06:23:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:23:48 INFO - 'LOGNAME': 'cltbld', 06:23:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:23:48 INFO - 'MOZ_NO_REMOTE': '1', 06:23:48 INFO - 'NO_EM_RESTART': '1', 06:23:48 INFO - 'PAGER': '/bin/cat', 06:23:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:23:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:23:48 INFO - 'PWD': '/builds/slave/test', 06:23:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:23:48 INFO - 'SHELL': '/bin/bash', 06:23:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K9zhye8C5Z/Listeners', 06:23:48 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 06:23:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:23:48 INFO - 'USER': 'cltbld', 06:23:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:23:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:23:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:23:48 INFO - 'XPC_FLAGS': '0x0', 06:23:48 INFO - 'XPC_SERVICE_NAME': '0', 06:23:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:23:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:23:48 INFO - Downloading/unpacking psutil>=3.1.1 06:23:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:23:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:23:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:23:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:23:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:23:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:23:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:23:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:23:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:23:52 INFO - Installing collected packages: psutil 06:23:52 INFO - Running setup.py install for psutil 06:23:52 INFO - building 'psutil._psutil_osx' extension 06:23:52 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 06:23:52 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 06:23:52 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 06:23:52 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 06:23:53 INFO - building 'psutil._psutil_posix' extension 06:23:53 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 06:23:53 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:23:53 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:23:53 INFO - ^ 06:23:53 INFO - 1 warning generated. 06:23:53 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 06:23:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:23:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:23:53 INFO - Successfully installed psutil 06:23:53 INFO - Cleaning up... 06:23:53 INFO - Return code: 0 06:23:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:23:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:23:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:23:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:23:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:23:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ddaf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd25570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2a3595540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dbc3d30>, '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 0x10d9e9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dbbbb20>, '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.3Y1PZSM4Ar/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.K9zhye8C5Z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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 06:23:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:23:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:23:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3Y1PZSM4Ar/Render', 06:23:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:23:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:23:53 INFO - 'HOME': '/Users/cltbld', 06:23:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:23:53 INFO - 'LOGNAME': 'cltbld', 06:23:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:23:53 INFO - 'MOZ_NO_REMOTE': '1', 06:23:53 INFO - 'NO_EM_RESTART': '1', 06:23:53 INFO - 'PAGER': '/bin/cat', 06:23:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:23:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:23:53 INFO - 'PWD': '/builds/slave/test', 06:23:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:23:53 INFO - 'SHELL': '/bin/bash', 06:23:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K9zhye8C5Z/Listeners', 06:23:53 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 06:23:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:23:53 INFO - 'USER': 'cltbld', 06:23:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:23:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:23:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:23:53 INFO - 'XPC_FLAGS': '0x0', 06:23:53 INFO - 'XPC_SERVICE_NAME': '0', 06:23:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:23:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:23:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:23:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:23:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:23:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:23:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:23:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:23:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:23:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:23:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:23:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:23:56 INFO - Installing collected packages: mozsystemmonitor 06:23:56 INFO - Running setup.py install for mozsystemmonitor 06:23:56 INFO - Successfully installed mozsystemmonitor 06:23:56 INFO - Cleaning up... 06:23:56 INFO - Return code: 0 06:23:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:23:56 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')]} 06:23:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:23:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:56 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')]} 06:23:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:23:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:56 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 0x10ddaf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd25570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2a3595540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dbc3d30>, '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 0x10d9e9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dbbbb20>, '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.3Y1PZSM4Ar/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.K9zhye8C5Z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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 06:23:56 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 06:23:56 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 06:23:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3Y1PZSM4Ar/Render', 06:23:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:23:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:23:56 INFO - 'HOME': '/Users/cltbld', 06:23:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:23:56 INFO - 'LOGNAME': 'cltbld', 06:23:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:23:56 INFO - 'MOZ_NO_REMOTE': '1', 06:23:56 INFO - 'NO_EM_RESTART': '1', 06:23:56 INFO - 'PAGER': '/bin/cat', 06:23:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:23:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:23:56 INFO - 'PWD': '/builds/slave/test', 06:23:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:23:56 INFO - 'SHELL': '/bin/bash', 06:23:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K9zhye8C5Z/Listeners', 06:23:56 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 06:23:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:23:56 INFO - 'USER': 'cltbld', 06:23:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:23:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:23:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:23:56 INFO - 'XPC_FLAGS': '0x0', 06:23:56 INFO - 'XPC_SERVICE_NAME': '0', 06:23:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:23:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:23:56 INFO - Downloading/unpacking jsonschema==2.5.1 06:23:56 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 06:23:56 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 06:23:56 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 06:23:56 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 06:23:56 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 06:23:56 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 06:23:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:23:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:23:59 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 06:23:59 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 06:23:59 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 06:23:59 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 06:23:59 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 06:23:59 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 06:23:59 INFO - Downloading functools32-3.2.3-2.tar.gz 06:23:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:23:59 INFO - warning: no files found matching '*.txt' 06:23:59 INFO - no previously-included directories found matching 'build' 06:23:59 INFO - no previously-included directories found matching 'dist' 06:23:59 INFO - no previously-included directories found matching '.git*' 06:23:59 INFO - Installing collected packages: jsonschema, functools32 06:23:59 INFO - Running setup.py install for functools32 06:23:59 INFO - warning: no files found matching '*.txt' 06:23:59 INFO - no previously-included directories found matching 'build' 06:23:59 INFO - no previously-included directories found matching 'dist' 06:23:59 INFO - no previously-included directories found matching '.git*' 06:24:00 INFO - Successfully installed jsonschema functools32 06:24:00 INFO - Cleaning up... 06:24:00 INFO - Return code: 0 06:24:00 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:24: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')]} 06:24:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:24:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24: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')]} 06:24:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:24:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ddaf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd25570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2a3595540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dbc3d30>, '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 0x10d9e9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dbbbb20>, '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.3Y1PZSM4Ar/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.K9zhye8C5Z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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 06:24:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:24:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 06:24:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3Y1PZSM4Ar/Render', 06:24:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:24:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:24:00 INFO - 'HOME': '/Users/cltbld', 06:24:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:24:00 INFO - 'LOGNAME': 'cltbld', 06:24:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:24:00 INFO - 'MOZ_NO_REMOTE': '1', 06:24:00 INFO - 'NO_EM_RESTART': '1', 06:24:00 INFO - 'PAGER': '/bin/cat', 06:24:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:24:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:24:00 INFO - 'PWD': '/builds/slave/test', 06:24:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:24:00 INFO - 'SHELL': '/bin/bash', 06:24:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K9zhye8C5Z/Listeners', 06:24:00 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 06:24:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:24:00 INFO - 'USER': 'cltbld', 06:24:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:24:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:24:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:24:00 INFO - 'XPC_FLAGS': '0x0', 06:24:00 INFO - 'XPC_SERVICE_NAME': '0', 06:24:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:24:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:24:00 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:24:00 INFO - Cleaning up... 06:24:00 INFO - Return code: 0 06:24:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:24: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')]} 06:24:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:24:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24: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')]} 06:24:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:24:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ddaf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd25570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2a3595540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dbc3d30>, '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 0x10d9e9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dbbbb20>, '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.3Y1PZSM4Ar/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.K9zhye8C5Z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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 06:24:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:24:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:24:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3Y1PZSM4Ar/Render', 06:24:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:24:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:24:00 INFO - 'HOME': '/Users/cltbld', 06:24:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:24:00 INFO - 'LOGNAME': 'cltbld', 06:24:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:24:00 INFO - 'MOZ_NO_REMOTE': '1', 06:24:00 INFO - 'NO_EM_RESTART': '1', 06:24:00 INFO - 'PAGER': '/bin/cat', 06:24:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:24:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:24:00 INFO - 'PWD': '/builds/slave/test', 06:24:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:24:00 INFO - 'SHELL': '/bin/bash', 06:24:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K9zhye8C5Z/Listeners', 06:24:00 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 06:24:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:24:00 INFO - 'USER': 'cltbld', 06:24:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:24:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:24:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:24:00 INFO - 'XPC_FLAGS': '0x0', 06:24:00 INFO - 'XPC_SERVICE_NAME': '0', 06:24:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:24:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:24:00 INFO - Downloading/unpacking blobuploader==1.2.4 06:24:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:24:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:24:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:24:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:24:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:24:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:24:02 INFO - Downloading blobuploader-1.2.4.tar.gz 06:24:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:24:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:24:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:24:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:24:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:24:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:24:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:24:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:24:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:24:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:24:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:24:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:24:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:24:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:24:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:24:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:24:04 INFO - Downloading docopt-0.6.1.tar.gz 06:24:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:24:04 INFO - Installing collected packages: blobuploader, requests, docopt 06:24:04 INFO - Running setup.py install for blobuploader 06:24:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:24:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:24:04 INFO - Running setup.py install for requests 06:24:04 INFO - Running setup.py install for docopt 06:24:05 INFO - Successfully installed blobuploader requests docopt 06:24:05 INFO - Cleaning up... 06:24:05 INFO - Return code: 0 06:24:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:24:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:24:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:24:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:24:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:24:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24:05 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 0x10ddaf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd25570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2a3595540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dbc3d30>, '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 0x10d9e9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dbbbb20>, '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.3Y1PZSM4Ar/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.K9zhye8C5Z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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 06:24:05 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 06:24:05 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 06:24:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3Y1PZSM4Ar/Render', 06:24:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:24:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:24:05 INFO - 'HOME': '/Users/cltbld', 06:24:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:24:05 INFO - 'LOGNAME': 'cltbld', 06:24:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:24:05 INFO - 'MOZ_NO_REMOTE': '1', 06:24:05 INFO - 'NO_EM_RESTART': '1', 06:24:05 INFO - 'PAGER': '/bin/cat', 06:24:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:24:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:24:05 INFO - 'PWD': '/builds/slave/test', 06:24:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:24:05 INFO - 'SHELL': '/bin/bash', 06:24:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K9zhye8C5Z/Listeners', 06:24:05 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 06:24:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:24:05 INFO - 'USER': 'cltbld', 06:24:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:24:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:24:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:24:05 INFO - 'XPC_FLAGS': '0x0', 06:24:05 INFO - 'XPC_SERVICE_NAME': '0', 06:24:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:24:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:24:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:24:05 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-PRzaB8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:24:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:24:05 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-EYzQWE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:24:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:24:05 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-KnXyDX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:24:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:24:05 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-Y8iPXH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:24:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:24:05 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-1LZEtM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:24:06 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-od6fsr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:24:06 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-VOkv1m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:24:06 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-dTqnz0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:24:06 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-peU9p4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:24:06 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-Nrauh2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:24:06 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-cUlPMh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:24:06 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-tq1SDz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:24:06 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-LojWZV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:24:06 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-ydqEOZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:24:06 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-I0QGXV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:24:07 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-fdn1nl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:24:07 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-yZMBmK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:24:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:24:07 INFO - Running setup.py install for manifestparser 06:24:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:24:07 INFO - Running setup.py install for mozcrash 06:24:07 INFO - Running setup.py install for mozdebug 06:24:07 INFO - Running setup.py install for mozdevice 06:24:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:24:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:24:07 INFO - Running setup.py install for mozfile 06:24:08 INFO - Running setup.py install for mozhttpd 06:24:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:24:08 INFO - Running setup.py install for mozinfo 06:24:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:24:08 INFO - Running setup.py install for mozInstall 06:24:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:24:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:24:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:24:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:24:08 INFO - Running setup.py install for mozleak 06:24:08 INFO - Running setup.py install for mozlog 06:24:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:24:08 INFO - Running setup.py install for moznetwork 06:24:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:24:08 INFO - Running setup.py install for mozprocess 06:24:09 INFO - Running setup.py install for mozprofile 06:24:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:24:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:24:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:24:09 INFO - Running setup.py install for mozrunner 06:24:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:24:09 INFO - Running setup.py install for mozscreenshot 06:24:09 INFO - Running setup.py install for moztest 06:24:09 INFO - Running setup.py install for mozversion 06:24:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:24:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:24:09 INFO - Cleaning up... 06:24:09 INFO - Return code: 0 06:24:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:24: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')]} 06:24:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:24:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24: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')]} 06:24:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:24:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24:09 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 0x10ddaf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd25570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2a3595540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dbc3d30>, '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 0x10d9e9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dbbbb20>, '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.3Y1PZSM4Ar/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.K9zhye8C5Z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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 06:24:09 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 06:24:09 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 06:24:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3Y1PZSM4Ar/Render', 06:24:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:24:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:24:09 INFO - 'HOME': '/Users/cltbld', 06:24:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:24:09 INFO - 'LOGNAME': 'cltbld', 06:24:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:24:09 INFO - 'MOZ_NO_REMOTE': '1', 06:24:09 INFO - 'NO_EM_RESTART': '1', 06:24:09 INFO - 'PAGER': '/bin/cat', 06:24:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:24:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:24:09 INFO - 'PWD': '/builds/slave/test', 06:24:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:24:09 INFO - 'SHELL': '/bin/bash', 06:24:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K9zhye8C5Z/Listeners', 06:24:09 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 06:24:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:24:09 INFO - 'USER': 'cltbld', 06:24:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:24:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:24:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:24:09 INFO - 'XPC_FLAGS': '0x0', 06:24:09 INFO - 'XPC_SERVICE_NAME': '0', 06:24:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:24:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:24:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:24:10 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-TLwpJv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:24:10 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)) 06:24:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:24:10 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-S3kOXR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:24:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:24:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:24:10 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-RQNIKO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:24:10 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)) 06:24:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:24:10 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-RHfvvZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:24:10 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)) 06:24:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:24:10 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-nhXcka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:24:10 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)) 06:24:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:24:10 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-V1ySJe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:24:10 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)) 06:24:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:24:10 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-Hts9mM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:24:10 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)) 06:24:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:24:10 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-e9wizL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:24:10 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)) 06:24:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:24:10 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-rmUwAc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:24:11 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)) 06:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:24:11 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-vLRBtR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:24:11 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)) 06:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:24:11 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-8R4Moh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:24:11 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)) 06:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:24:11 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-1_Z0OT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:24:11 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)) 06:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:24:11 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-8DgQMl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:24:11 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)) 06:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:24:11 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-0ZPhsE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:24:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 06:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:24:11 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-9QyfDU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:24:11 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)) 06:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:24:11 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-83DAc0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:24:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 06:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:24:11 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-rZHQky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:24:11 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)) 06:24:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:24:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:24:11 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)) 06:24:11 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)) 06:24:11 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)) 06:24:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:24:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:24:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:24:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:24:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:24:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:24:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:24:14 INFO - Downloading blessings-1.6.tar.gz 06:24:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:24:14 INFO - Installing collected packages: blessings 06:24:14 INFO - Running setup.py install for blessings 06:24:14 INFO - Successfully installed blessings 06:24:14 INFO - Cleaning up... 06:24:14 INFO - Return code: 0 06:24:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:24:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:24:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:24:15 INFO - Reading from file tmpfile_stdout 06:24:15 INFO - Current package versions: 06:24:15 INFO - blessings == 1.6 06:24:15 INFO - blobuploader == 1.2.4 06:24:15 INFO - docopt == 0.6.1 06:24:15 INFO - functools32 == 3.2.3-2 06:24:15 INFO - jsonschema == 2.5.1 06:24:15 INFO - manifestparser == 1.1 06:24:15 INFO - mozInstall == 1.12 06:24:15 INFO - mozcrash == 0.17 06:24:15 INFO - mozdebug == 0.1 06:24:15 INFO - mozdevice == 0.48 06:24:15 INFO - mozfile == 1.2 06:24:15 INFO - mozhttpd == 0.7 06:24:15 INFO - mozinfo == 0.9 06:24:15 INFO - mozleak == 0.1 06:24:15 INFO - mozlog == 3.4 06:24:15 INFO - moznetwork == 0.27 06:24:15 INFO - mozprocess == 0.23 06:24:15 INFO - mozprofile == 0.28 06:24:15 INFO - mozrunner == 6.12 06:24:15 INFO - mozscreenshot == 0.1 06:24:15 INFO - mozsystemmonitor == 0.3 06:24:15 INFO - moztest == 0.7 06:24:15 INFO - mozversion == 1.4 06:24:15 INFO - psutil == 3.1.1 06:24:15 INFO - requests == 1.2.3 06:24:15 INFO - wsgiref == 0.1.2 06:24:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:24:15 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')]} 06:24:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:24:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24:15 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')]} 06:24:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:24:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24:15 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 0x10ddaf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd25570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2a3595540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dbc3d30>, '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 0x10d9e9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dbbbb20>, '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.3Y1PZSM4Ar/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.K9zhye8C5Z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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 06:24:15 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 06:24:15 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 06:24:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3Y1PZSM4Ar/Render', 06:24:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:24:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:24:15 INFO - 'HOME': '/Users/cltbld', 06:24:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:24:15 INFO - 'LOGNAME': 'cltbld', 06:24:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:24:15 INFO - 'MOZ_NO_REMOTE': '1', 06:24:15 INFO - 'NO_EM_RESTART': '1', 06:24:15 INFO - 'PAGER': '/bin/cat', 06:24:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:24:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:24:15 INFO - 'PWD': '/builds/slave/test', 06:24:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:24:15 INFO - 'SHELL': '/bin/bash', 06:24:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K9zhye8C5Z/Listeners', 06:24:15 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 06:24:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:24:15 INFO - 'USER': 'cltbld', 06:24:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:24:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:24:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:24:15 INFO - 'XPC_FLAGS': '0x0', 06:24:15 INFO - 'XPC_SERVICE_NAME': '0', 06:24:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:24:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:24:16 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)) 06:24:16 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)) 06:24:16 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)) 06:24:16 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)) 06:24:16 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)) 06:24:16 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)) 06:24:16 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)) 06:24:16 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)) 06:24:16 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)) 06:24:16 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)) 06:24:16 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)) 06:24:16 INFO - Cleaning up... 06:24:16 INFO - Return code: 0 06:24:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:24:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:24:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:24:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:24:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:24:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24:16 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 0x10ddaf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd25570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2a3595540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dbc3d30>, '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 0x10d9e9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dbbbb20>, '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.3Y1PZSM4Ar/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.K9zhye8C5Z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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 06:24:16 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 06:24:16 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 06:24:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3Y1PZSM4Ar/Render', 06:24:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:24:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:24:16 INFO - 'HOME': '/Users/cltbld', 06:24:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:24:16 INFO - 'LOGNAME': 'cltbld', 06:24:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:24:16 INFO - 'MOZ_NO_REMOTE': '1', 06:24:16 INFO - 'NO_EM_RESTART': '1', 06:24:16 INFO - 'PAGER': '/bin/cat', 06:24:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:24:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:24:16 INFO - 'PWD': '/builds/slave/test', 06:24:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:24:16 INFO - 'SHELL': '/bin/bash', 06:24:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K9zhye8C5Z/Listeners', 06:24:16 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 06:24:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:24:16 INFO - 'USER': 'cltbld', 06:24:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:24:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:24:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:24:16 INFO - 'XPC_FLAGS': '0x0', 06:24:16 INFO - 'XPC_SERVICE_NAME': '0', 06:24:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:24:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:24:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:24:16 INFO - Cleaning up... 06:24:16 INFO - Return code: 0 06:24:16 INFO - Running post-action listener: _resource_record_post_action 06:24:16 INFO - Running post-action listener: _start_resource_monitoring 06:24:16 INFO - Starting resource monitoring. 06:24:16 INFO - [mozharness: 2016-10-12 13:24:16.863643Z] Finished create-virtualenv step (success) 06:24:16 INFO - [mozharness: 2016-10-12 13:24:16.864673Z] Running install step. 06:24:16 INFO - Running pre-action listener: _resource_record_pre_action 06:24:16 INFO - Running main action method: install 06:24:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:24:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:24:17 INFO - Reading from file tmpfile_stdout 06:24:17 INFO - Detecting whether we're running mozinstall >=1.0... 06:24:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:24:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:24:17 INFO - Reading from file tmpfile_stdout 06:24:17 INFO - Output received: 06:24:17 INFO - Usage: mozinstall [options] installer 06:24:17 INFO - Options: 06:24:17 INFO - -h, --help show this help message and exit 06:24:17 INFO - -d DEST, --destination=DEST 06:24:17 INFO - Directory to install application into. [default: 06:24:17 INFO - "/builds/slave/test"] 06:24:17 INFO - --app=APP Application being installed. [default: firefox] 06:24:17 INFO - mkdir: /builds/slave/test/build/application 06:24:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 06:24:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 06:24:51 INFO - Reading from file tmpfile_stdout 06:24:51 INFO - Output received: 06:24:51 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 06:24:51 INFO - Running post-action listener: _resource_record_post_action 06:24:51 INFO - [mozharness: 2016-10-12 13:24:51.977651Z] Finished install step (success) 06:24:51 INFO - [mozharness: 2016-10-12 13:24:51.977776Z] Running run-tests step. 06:24:51 INFO - Running pre-action listener: _resource_record_pre_action 06:24:51 INFO - Running main action method: run_tests 06:24:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:24:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:24:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:24:51 INFO - 2016-10-12 06:24:51.992 screenresolution[1642:8356] starting screenresolution argv=screenresolution get 06:24:51 INFO - 2016-10-12 06:24:51.994 screenresolution[1642:8356] Display 0: 1600x1200x32@60 06:24:52 INFO - 2016-10-12 06:24:52.000 screenresolution[1643:8358] starting screenresolution argv=screenresolution list 06:24:52 INFO - Available Modes on Display 0 06:24:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:24:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:24:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:24:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:24:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:24:52 INFO - Intel Iris: 06:24:52 INFO - Chipset Model: Intel Iris 06:24:52 INFO - Type: GPU 06:24:52 INFO - Bus: Built-In 06:24:52 INFO - VRAM (Dynamic, Max): 1536 MB 06:24:52 INFO - Vendor: Intel (0x8086) 06:24:52 INFO - Device ID: 0x0a2e 06:24:52 INFO - Revision ID: 0x0009 06:24:52 INFO - Displays: 06:24:52 INFO - Display: 06:24:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:24:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:24:52 INFO - Display Serial Number: 1600x1200 60 06:24:52 INFO - Main Display: Yes 06:24:52 INFO - Mirror: Off 06:24:52 INFO - Online: Yes 06:24:52 INFO - Rotation: Supported 06:24:52 INFO - Return code: 0 06:24:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:24:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:24:52 INFO - Python 2.7.3 06:24:52 INFO - Return code: 0 06:24:52 INFO - grabbing minidump binary from tooltool 06:24:52 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')]} 06:24:52 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 0x10dbc3d30>, '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 0x10d9e9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dbbbb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:24:52 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 06:24:52 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 06:24:52 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 06:24:52 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:24:52 INFO - Return code: 0 06:24:52 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:24:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:24:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:24:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:24:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:24:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/duYfj-nyRXajoKc14IB9NA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0094', '--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 06:24:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/duYfj-nyRXajoKc14IB9NA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0094 --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 06:24:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3Y1PZSM4Ar/Render', 06:24:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:24:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:24:52 INFO - 'HOME': '/Users/cltbld', 06:24:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:24:52 INFO - 'LOGNAME': 'cltbld', 06:24:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:24:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:24:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:24:52 INFO - 'MOZ_NO_REMOTE': '1', 06:24:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:24:52 INFO - 'NO_EM_RESTART': '1', 06:24:52 INFO - 'PAGER': '/bin/cat', 06:24:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:24:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:24:52 INFO - 'PWD': '/builds/slave/test', 06:24:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:24:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:24:52 INFO - 'SHELL': '/bin/bash', 06:24:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K9zhye8C5Z/Listeners', 06:24:52 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 06:24:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:24:52 INFO - 'USER': 'cltbld', 06:24:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:24:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:24:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:24:52 INFO - 'XPC_FLAGS': '0x0', 06:24:52 INFO - 'XPC_SERVICE_NAME': '0', 06:24:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:24:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/duYfj-nyRXajoKc14IB9NA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0094', '--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 06:24:52 INFO - mozversion application_buildid: 20161012030748 06:24:52 INFO - mozversion application_changeset: aa8629a25ab5aeb2678a0187e50336659d368b44 06:24:52 INFO - mozversion application_display_name: Nightly 06:24:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:24:52 INFO - mozversion application_name: Firefox 06:24:52 INFO - mozversion application_remotingname: firefox 06:24:52 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:24:52 INFO - mozversion application_vendor: Mozilla 06:24:52 INFO - mozversion application_version: 52.0a1 06:24:52 INFO - mozversion platform_buildid: 20161012030748 06:24:52 INFO - mozversion platform_changeset: aa8629a25ab5aeb2678a0187e50336659d368b44 06:24:52 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:24:52 INFO - mozversion platform_version: 52.0a1 06:24:52 INFO - using testdate: 1476278692 06:24:52 INFO - actual date: 1476278692 06:24:52 INFO - starting webserver on 'localhost:49277' 06:24:52 INFO - SUITE-START | Running 2 tests 06:24:52 INFO - TEST-START | dromaeo_css 06:24:52 INFO - operating with platform_type : mac_ 06:24:52 INFO - Initialising browser for dromaeo_css test... 06:24:52 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/tmpo02inX/profile http://localhost:49277/getInfo.html) 06:24:55 INFO - PROCESS | 1653 | 2016-10-12 06:24:55.785 plugin-container[1656:8531] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4b43, name = 'com.apple.tsm.portname' 06:24:55 INFO - PROCESS | 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:24:55 INFO - PROCESS | 1653 | 2016-10-12 06:24:55.788 plugin-container[1656:8531] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9403, name = 'com.apple.CFPasteboardClient' 06:24:55 INFO - PROCESS | 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:24:55 INFO - PROCESS | 1653 | 2016-10-12 06:24:55.788 plugin-container[1656:8531] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 06:24:55 INFO - PROCESS | 1653 | __metrics Screen width/height:1600/1200 06:24:55 INFO - PROCESS | 1653 | colorDepth:24 06:24:55 INFO - PROCESS | 1653 | Browser inner width/height: 1024/689 06:24:55 INFO - PROCESS | 1653 | __metrics 06:24:56 ERROR - PROCESS | 1653 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3083: TypeError: this.tabs is undefined 06:24:56 INFO - TEST-INFO | 1653: exit 0 06:24:56 INFO - Browser initialized. 06:24:56 INFO - Running cycle 1/1 for dromaeo_css test... 06:24:56 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/tmpo02inX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:24:59 INFO - PROCESS | 1658 | 2016-10-12 06:24:59.271 plugin-container[1659:8654] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x863f, name = 'com.apple.tsm.portname' 06:24:59 INFO - PROCESS | 1658 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:24:59 INFO - PROCESS | 1658 | 2016-10-12 06:24:59.272 plugin-container[1659:8654] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a0f, name = 'com.apple.CFPasteboardClient' 06:24:59 INFO - PROCESS | 1658 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:24:59 INFO - PROCESS | 1658 | 2016-10-12 06:24:59.272 plugin-container[1659:8654] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 06:25:08 INFO - PROCESS | 1658 | RSS: Main: 238424064 06:25:08 INFO - PROCESS | 1658 | 06:25:58 INFO - PROCESS | 1658 | 1476278758633 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 06:28:12 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49277/tests/dromaeo/cssquery-ext.html) 06:28:13 INFO - PROCESS | 1658 | RSS: Main: 251744256 06:28:13 INFO - PROCESS | 1658 | 06:31:15 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-ext.html (next: http://localhost:49277/tests/dromaeo/cssquery-jquery.html) 06:31:16 INFO - PROCESS | 1658 | RSS: Main: 263405568 06:31:16 INFO - PROCESS | 1658 | 06:34:18 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49277/tests/dromaeo/cssquery-mootools.html) 06:34:18 INFO - PROCESS | 1658 | RSS: Main: 269463552 06:34:18 INFO - PROCESS | 1658 | 06:37:20 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49277/tests/dromaeo/cssquery-prototype.html) 06:37:21 INFO - PROCESS | 1658 | RSS: Main: 269946880 06:37:21 INFO - PROCESS | 1658 | 06:40:24 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49277/tests/dromaeo/cssquery-yui.html) 06:40:24 INFO - PROCESS | 1658 | RSS: Main: 275275776 06:40:24 INFO - PROCESS | 1658 | 06:43:27 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-yui.html (next: http://localhost:49277/tests/dromaeo/cssquery-dojo.html) 06:43:27 INFO - PROCESS | 1658 | RSS: Main: 278147072 06:43:27 INFO - PROCESS | 1658 | 06:43:27 INFO - PROCESS | 1658 | __start_tp_report 06:43:27 INFO - PROCESS | 1658 | _x_x_mozilla_page_load 06:43:27 INFO - PROCESS | 1658 | _x_x_mozilla_page_load_details 06:43:27 INFO - PROCESS | 1658 | |i|pagename|runs| 06:43:27 INFO - PROCESS | 1658 | |0;dojo.html;3285.40862644724;3328.5672862527867;3340.549025881506;3340.5991281046277;3361.3781450431657;5399.217113518537;5517.862053448661;5533.501984821375;5542.63972841765;5601.075822489294;4844.055409195208;5406.621536492447;5506.421825708303;5553.305836770403;5607.663540187592;4991;5021.648484606079;5129.281900533928;5139.640225184238;5170.819021334254;5015.949840501603;5173.715445650488;5201.661891977028;5202.089634313998;5206.45332240115;4993.725345106018;5044.798208071673;5123.001014802115;5146;5149.150390185615;4993.201087825967;5056.342675452204;5070.188769796815;5112.642115051948;5149.356330458692;4240.554741752133;5038.5969122470115;5038.748062596892;5047.772850221749;5111.1566591512355;5387.892242155174;5398.00136974657;5527.364353099365;5543.223948647193;5579.972100139514;5897.675627840467;5944.405559444064;6026;6058.636481811105;6109.2528441424865;6143.907841382383;6146.385361463863;6152.507799376039;6154.107654390088;6160.414760597736;4230.936535951963;5709.65742055478;5715.085586306171;5731.083026715705;5736.913946290809;6014.1580178775;6080.665563394055;6093.081586421939;6117.2184870185665;6139.492138333381;5883.529317654577;5968.1942937703725;5972.462478376967;5974.1934838796205;6010.759569617254;6056.909146362808;6097.298810636834;6129.754809807558;6130;6144.201253837062;5858.8535286617325;5933.851653708605;5969.582129250911;6002.459778619946;6023.45788879003;4963.875903102379;6065.8180254592435;6071.635701857815;6077.483413909778;6128.724207410677;4668.39310889589;4806.447258565309;4808.35087263215;4812.374391329105;4858.6356023298395;4283.507396649363;4288.699791014599;4300.204462174508;4380.737155770664;4404.823807047682;5534.391216966131;5577.6932268724795;5605.131204663284;5616.887662246814;5630.746616402272;6027.975244208407;6085.6348619083;6100.816975490742;6106.084087386838;6119.112728654321;5553.416891226444;5588.580856435702;5593.300837395325;5597;5599.32808063035;4443.822247110079;5267.183586544092;5269.841904742864;5278.392984806719;5286.9471305287225;6094.8171554853425;6106.339326077157;6106.399996025858;6121.57491608479;6127;5411.323584551931;6039.094135879654;6039.758409663565;6060.151578779062;6087.269527656709;4727.834525791718;5091.465396133501;6160.7535698571555;6185.690715464299;6186.721597528032;4908.950910490849;5119.155339368963;5870.589058765845;5870.735816888165;5916.083007133901;6052.515798736003;6114.205153330038;6134.907976380268;6164.013757798731;6170.413810687977;6017.608855424383;6021.126936594257;6026.548008899263;6031.215941927521;6039.909401358896;5661.688607126483;5947.226860508279;6008.579399441997;6024.849378765566;6039.63762174271;5645.322561292671;5672.631278966854;5699.5725320600295;5800.24596802413;5878.382769809108;5970.462658360769;5995.850103747442;5995.940040599713;5997.850053748692;6010.939890601038;5534.889302213853;5830.766769329349;5840.2991641003355;5887.646741195542;5894.233749612523 06:43:27 INFO - PROCESS | 1658 | |1;ext.html;458.68121655449477;473.9549742774435;515.1962937817005;528.5612941258754;529.0450736420761;40000.799996000016;41549.79225103878;41737.58262417375;41800.95497612561;43356.91607709801;35959.4606080909;42136;42671.35992960108;42877.57122428783;42976.35535466971;9440.19758320542;9602.663906763264;9628.229741620653;9713.562889669982;9750.951245243763;9549.809003819919;9569.282303827205;9650.08324209199;9664.323497355188;9671.70984870455;9594.04059594042;9613.086756758097;9653.662121825737;9657.275704322205;9702;8234.752957411287;9599.664011759554;9614.230861531096;9624.759381015461;9718.70843874685;9552.808943821085;9630.614775408976;9642.951785241099;9678.370905891165;9684.70945871625;40305;40633.98415039618;40717;40754.796226018974;40756.18487630261;3310.668933106694;3328.766986310935;3333.1333853198103;3355.681210285019;3361.5461912641726;27674.446511069866;27751.861240693666;27961.720382796117;28149.718502814914;28520.572191417144;2786.763125134366;3225.0808519572042;3243.5459035735016;3260.3642289753507;3335.5663763710804;471157;472474.6376268131;473832;473839;474129;57946;58260;58288.41711582915;58319.833603327694;58336;61046.08430873541;61196.082058769156;61480.69259653673;61501.69249153726;61609.69195153996;15484.225788710519;15616.76574851378;15829.68340633181;15900.045997239971;16085.919570402073;10417.583296668048;12855.935720321339;12861.678458038625;12897.613071607866;13075.869241307655;17332.220050097774;17408.912955435142;17543.807024121983;17673.027983461034;17703.911480442774;6374.968125159345;6557.573697731775;6560.704768285439;6577.6711164441585;6644.734210631617;702.8980797784293;892.9330300227509;931.6878845586668;932.6455946740331;1046.895310468947;25537.744622553535;28107.016254430997;28841;29555.817767289496;30693.846530767205;1050.753073027838;1059.9417032063157;1135.5287555664472;1169.502961241486;1192.6899006258436;15288.847111528965;15538.300776465087;15565.533034008999;15582.06507609547;16081;638707;639407;641299;642680;642886;57057.14414283789;57580.42419575751;58725.825483490094;62686.0597091044;62789.744205116556;1118.2060736876747;1326.3103186343048;1356.87109724576;1365.0308281120515;1369.9794503082262;30421.087367379016;30829.69170308358;30846.383072338875;31170.68829311678;31568;50775.746121269156;51036;51048;51608.96782064413;51969;597296;599374.003129999;600416;601119.9944000252;601416;25879.611805823304;25930.22209333723;26017.479650407266;26158.476830462903;26511.469770604093;37358;46580.30129548127;46746;46929.765351173024;46983.53016469791;37835.86492405232;39372.60627393689;39384.6061539381;39763.20473590454;40110;32989.83505082459;34075.14812129716;38399.04002399962;39729.40405893972;39829.00427489336;31632;37487.62512374841;38044.23911521809;38525.6147438522;38994.6100538991;33421.83289083539;34005.48991765076;34737.65262347445;34839;34925.9522214334;23911.760882390954;24353.39116522101;25074.24777256685;25469.3632659185;25961.740382595934 06:43:27 INFO - PROCESS | 1658 | |2;jquery.html;328.3334830294503;363.8508211633231;364.92883887641904;371.8809980806141;391.6416478921787;15096.943213974999;15404.613584777368;18431.539211519717;18884.716729249056;19775.703364449546;16704.164791760395;19313.71029434556;19380.321688740896;19620.411387658394;20485.590288194227;5664.1220610805185;6029.60807547508;6034.909476357836;6044.365341639131;6049.546284028694;5698.8005419810315;5909;5973.014452615335;6024.548158888079;6041.697915104249;5119.001794650045;5862.589618726691;5968.701564921758;5980.073088671263;5989.8203053908455;5683.54531637468;5887.646741195542;5926.348101708809;5928.110783382484;5930.229070220844;4454.864009677544;5177.844664660066;5180.300659410969;5183.352080989876;5190.117679994372;24139;24242.878785606135;24513.509729805482;24525.38686532833;24585.262442126765;2256.763039880805;2327.0459111764267;2414.637804329347;2566.781823545001;2847.458982793283;14521.12873227599;15189.848101518954;15390.923045384814;15412;15947.282372293159;1781.4833698227499;1818.163644723429;1874.240932422371;1945.0177660281468;1973.8716983396034;114644;117112.24331634947;117313;117580;118040.40979795046;10569.841452378221;10829.187810914213;10898.945505272422;11072.501737421835;11262.436878156223;13386.531471398454;13704.10923290003;13719.862801372059;13733.176009439465;13735.96980226487;8200.876986845202;8399.538025408661;8505.31957443403;8594.140585941355;8637;8402.957985210034;8471.618777155043;8495.490270583785;8668.523231222343;8687.478751274944;6497.122888410098;6625.337466253336;6636.369544893324;6648.301928297556;6745.258021617618;1534.6010037390135;1812.5015620704412;1831.7710286214224;1857.5541869951114;1866.3561071430336;845.3997661660167;880.3309484791605;910.2308549275851;945.645382981382;994.3642707745718;20833.68749468759;21492.677609835864;21804.236851710113;21902.23342183016;21936.341909742732;913.1735779119907;936.7096200177966;955.7419496735843;1003.6938733686296;1011.438651548383;8349.749507514784;11573.942130289463;11586.420678966018;11619.95420412167;11639.53441862316;516237;558640;564529.2489608817;565117;593766;61003;82981.17018829855;102274;103235;104984.95015049905;434.7304671103936;454.3094496365506;457.5150340638933;1057.5241141486363;1061.686802393296;10329.29566621529;10585.671152346471;10767.300125491818;10985.340879546933;11041.447927603427;44482.55517444784;53257;53535.46464535305;54584.72707636436;56567.58581035507;70400;77483;78137;78164.60917695375;78789.60605196937;6658.866822663616;7821.765347039598;7962.32320252785;8002.759917202493;8259.174082591693;10178;10528.736781580521;10867.673969780919;11619.767604648028;12559.120861539604;10294.742631433974;10467.371957682564;10640.255182137485;10815.24293299493;10858;8152.470089444168;8924.553772311489;9172.770680733034;10262.076413122855;10615.1507879371;8941.597628106621;9647.565859536197;10552.577896884346;10862.619808306672;10904.291221070605;7842.843143137219;7905.367570594453;7992.480488768211;8059.798505037421;8104.79738006531;9075.954620227121;10585.311954722918;10756.83864742045;10789;10798.082163015917 06:43:27 INFO - PROCESS | 1658 | |3;mootools.html;1393.2337214532008;1472.9410823567057;1668.6245594741185;1800.5678637127094;1827.6436094961489;7877.80305492363;8163.795905102375;8324;8927.28581713463;8942;8394.538300393477;8688;8688.478691278528;8789.121087891208;8814.118588141182;2183.716116904808;2187.814035806958;2214.6124428225075;2220.4781876259067;2223.266322113707;2196.527746534495;2220.678001689754;2243.046705150313;2250.4036430345973;2252.256755270757;2244.7755224477505;2247.3370355745014;2255.154317131076;2256.8645881247094;2263.569921714877;2202.064122747826;2208.392692009694;2217.6230040893006;2224.8776317302622;2227.866328020324;1916.7987361327;2219.3341997400876;2229.175205174096;2234.944126396853;2247.1460844878843;8632.65469381224;8776.210141087333;8779.692710755093;8785.121487851227;8797.824043519095;5020.874478138039;5170.508801663874;5178.042062218502;5179.741012949337;5196.168613021899;3352.6312105668358;3357.6306606273292;3575.6424357564297;3576.499290099388;3579.7673151245344;1040.921930855189;1041.5989843910074;1062.4369084385212;1063.9680809575725;1073.608133031438;10975;11286.097112231002;11331.37677427741;11334.149938754626;11531.48108335127;3803.7717736935874;3949.19041596472;4118.670506359484;4448.733076015449;4477.597016268552;8884.200421962054;8952.328575356874;9013.63945442175;9025.954870225607;9063.184313411824;5130.846074617767;5140.922886156711;5141.5886729061585;5153.2785410042625;5155.278261043457;4051.331530297527;4335.761533115646;4338.501072376654;4783.880402989953;4794.256890182028;3536.41649127891;3591.569011718558;3594.6225646307284;3609.4224924012033;3699;1119.8880111988735;1122.354646078508;1127.312339472921;1127.6729748373043;1134.597217987619;634.2990994950513;724.4204636290946;796.3151689546985;850.9363295880149;861.0743450790426;4693.647976401783;4701.318308845198;5359.812406565751;5797.391273916262;5829.183914252008;891.9286457083417;910.8132832769267;960.6925783749273;961.8124465729255;991.8809742830762;3704.4258139988347;3823.3882578787816;3958.802059896994;4015.7992100394863;4041.413994970713;9733.367331123454;10292.948535257276;10527.052565269163;10533.420661863518;10579.047885690325;9742.366746161477;10372.27394082407;10488.108510776518;10497.160227181806;10519.737006574744;7835.373170146375;7839.725609603751;8095.502332068586;8108.999999999882;8115.634796434175;4920.360353154067;5630.859228519156;5636.802711905064;5654.830355089354;5773.672055427338;8885.822283554164;9487.573059212215;9737.318387712792;9789.46157961319;9851.950740246253;9801.509924503604;9943.30396872212;9955.751106222402;10010.599576016877;10068.194544436574;6858.5199036067;7106.893396599158;7187.676554554953;7392.4086073115095;7507.399408047452;8087.150849160754;8216.753497395088;8341.874871876806;8346.62440190205;8349.582520874053;7206.747763828241;7287.927120728725;7295.088113985752;7347.08161479815;7449.515781474403;7261.6006119663925;7283.198848126808;7293.890591641236;7305.305995930378;7354.521956072838;6823.078884350549;6835.93164068353;6907.930920690729;6914.377706006484;6919.169699635874;4918.114739346952;4927.310176575211;4955.851324460272;4969.975150124371;4994.4755800640405;4737.928931066106;4970.254461830755;5024.673396229234;5082.618803589819;5099.209622508517 06:43:27 INFO - PROCESS | 1658 | |4;prototype.html;293.2975523620929;296.27117291463;304.5492670847147;305.7141572629593;311.2328111205877;4804.71171729696;5044.495550444954;5165.767540460679;5282.366116066068;5438.395673276383;4834.323194752737;5088.974555127219;5261.184516399964;5267.551423358578;5287.28621636079;3605.9098522536883;4106.650934670549;4123.628873401393;4137.482814648169;4157.3140431828715;3285;3438.363902678;3647.908802279951;3910.1788624388914;4168.499780026401;3052.8320942348164;3356.127406874206;3490.616032236452;3712.2575484903127;4060.2894493463673;3386.458166693342;3502.390718914425;3572.857085716594;4041.3533834586324;4053.716239863211;3121.59419275495;3470.7917524948584;3566.982165089184;3573.767705099186;3595.352836489431;4962.503749625044;5040.143175660147;5135.512126348029;5137.12668846297;5236.324376199617;4210.3684447332835;4667.346571479996;4678.274867395559;4686;4698.553637404441;4707.364505791708;4832.73419961902;5542.612017158801;5563.415841336682;5566.359868615121;3296.5055241713935;3430.953559164479;3941.2314598653275;3949.3483575210057;3991.7604943703473;4936.950630493721;5803.448672376117;5875.2949646042325;5890.852728681774;5925.762969481216;3428.468587368962;3448.827558622059;3727.415848264531;3875.701639950592;3892.2799282132896;3887.814216663888;3914.3149948758855;3927.3912543555793;3966.861159859391;3976.9602303977167;4113.835446582103;4271.081717430768;4580.519045500175;4592.839250626212;4609.331646911246;5045.8738531537;5513;5690.6870122142855;5708.229389032511;5722.628029178173;1118.278710231896;1230.56930074475;1297.195738642048;1308;1344.536135033412;881.7266647339345;890.172139909877;895.8029233568604;901.2249465459699;913.6254135804421;4903.901921961612;5231.8168864089575;5247.927068807876;5254.527092561688;5337.825678350757;5575.944240557624;5683.943160568341;5714.714264286769;5745.052066409079;5932.940670593325;4991.450940396553;5010.41963388855;5399.784008639689;5400.91898621521;5435.994341046919;2543.376872666209;2719.9184024479296;2869.483492971285;2960.8371539565533;3070.9539356909663;5012.749362531858;5160.690358578498;5422.457754224546;5628.943710562842;5943.732532036069;5489.478499542537;5538.695371754592;6027.48766354856;6037.18498002764;6060.303165091492;4927.236278376858;5344.781915505099;5762.8795411281135;6055.273367195965;6126.969365153146;4912.336834527436;5520.475554822286;5562.9443705564045;5569.944300557105;5617.634853734658;5845.532357411482;5846.532277417711;5856.795012174553;5867.090600956859;5935.614185077956;4679.461861885927;5669;5710.2576665033275;5797.275280618102;6079.1185278133535;3473.305338932173;3837.6162383762517;3855.807209639563;3885.4171874217964;3905.297046531538;4989.950100498949;5830.358660547252;5880;5919.526437885045;5958;4715.976420118015;5395.622306438669;5651.15232715096;5657.43425657431;5676.7161641918565;5554.166874968787;5579.776808927598;5686.545076393796;5723.771049157987;5724.685142317046;4884.633652476007;5237.81667641646;5268.473152684701;5449.6375906023495;5486.588505862156;5587.69267690281;5623.690697011703;5639.392773059658;5640.746166422603;5683.60214784961;4493.460784705856;5247.947520524898;5534.920690465482;5537.7784888604;5588.469095435927 06:43:27 INFO - PROCESS | 1658 | |5;yui.html;601.0713447723267;697.5535657179403;729.5693363096856;735.9595222262777;765.4871236271697;12466;12695.98432125429;14260.857391426083;14438.855611443882;14618.707625847477;12896.677583060427;13168;13175.604731858035;13260.602181934557;13312.20126792393;802.9518228906255;823.0658202939646;827.8799574061758;828.0891019878115;828.8963879515061;656.8259411256021;675.304436430475;802.6749166587513;817.1379194949326;826.557791581504;863.3567991846083;867.7743786615463;872.7905302727363;877.9385443018991;878.3456325037823;751.5941391648503;872.3239489395705;874.1695389380083;874.4753148111146;875.5097145598485;647.5014239035916;648.4747354642755;649.4706813946666;650.3756393861898;653.183520599251;13203.933980330037;13356.73286534264;13390.330483475886;13392.397342119628;13451.192928424325;12637.557685481055;13401.66495837612;14243;14387.71224575513;14721.92639036798;9157.025287745933;11736.823947640793;11741.941290293495;11844.526218951232;12001.154435620314;3706.9073273168387;3758.906027349311;3768.4724138620613;3786.4320351947154;3892.785896775676;112376;114288.14279642992;114850;116005;117761;10926.235163538635;10930.508127134299;10971.83542246867;10982.505787239594;11369;22079.33761987143;22267.443313917283;22395.21616743406;22425.21511747081;22460.663090053662;6424.13274207976;6927.826804329932;7504.137024242173;7799.064112306446;8219.301359384519;4457.086297309044;4479.529649386767;4485.573870482299;4499.775011249424;4529.796159172779;3494.759360427063;3560.0565850049757;3605.8197090145386;3616.0959760059986;3623.0942264433893;641.2017038786647;644.4747530762413;644.932282110381;660.207750699163;663.4592806862488;640.7533099756535;642.9905049073004;654.107143748789;654.3325807676239;659.8185498987817;9204.63181472747;9308.95345523268;9326.300527460331;9517.23862091031;9620.230381569458;552.3675391676508;585.2128886647538;648.2091847945499;659.7756762700704;695.9838635592092;4554.931676024862;4673.018666080161;4675.906481870412;4704;4757.476677565534;95733.52133239289;121382.39308803399;127465.36267318604;155134;160217;109620;110361.24096897482;133210;143397;146819;101013.49493252634;121191;122289.38855305666;124467.75532244742;126106;8513.659453621785;8543.40196186261;8848.64605415802;9044.321675874204;9199.470145709716;46961.76519117383;48488.757556212;51501.227481588554;57997;62287.37712622816;72118.63940680263;91247.17505649982;91486;92071.53964230136;92241;11434.028107610946;11531;11655.41722913834;11830.40847957616;11858.051355891681;12258.877411225774;12379.566715164927;12443.128980971245;12486.188397754117;12865.356732163542;11729.706757331134;11961.547882684203;11979.101567382308;12320.753584928072;12358.196717213352;11371.886281137082;11422.428878556206;11703.180777345504;11932.343721095423;12323.198992065487;11527.481263343338;11574;11575.652730418102;11642.359670218219;11923;9422.811543769223;9794.412335259907;10000.949995249977;10075.949620251851;10504.894951050392;10443.268971172249;10802.351858888493;11370.488328025423;11487.885121148682;11560.826587601025 06:43:27 INFO - PROCESS | 1658 | __end_tp_report 06:43:27 INFO - PROCESS | 1658 | __start_cc_report 06:43:27 INFO - PROCESS | 1658 | _x_x_mozilla_cycle_collect,369 06:43:27 INFO - PROCESS | 1658 | __end_cc_report 06:43:27 INFO - PROCESS | 1658 | __startTimestamp1476279807694__endTimestamp 06:43:27 INFO - PROCESS | 1658 | 06:43:27 INFO - PROCESS | 1658 | ------- Summary: start ------- 06:43:27 INFO - PROCESS | 1658 | Number of tests: 6 06:43:27 INFO - PROCESS | 1658 | 06:43:27 INFO - PROCESS | 1658 | [#0] dojo.html Cycles:165 Average:5544.44 Median:5709.66 stddev:640.04 (11.2%) stddev-sans-first:616.98 06:43:27 INFO - PROCESS | 1658 | Values: 3285.4 3328.6 3340.5 3340.6 3361.4 5399.2 5517.9 5533.5 5542.6 5601.1 4844.1 5406.6 5506.4 5553.3 5607.7 4991.0 5021.6 5129.3 5139.6 5170.8 5015.9 5173.7 5201.7 5202.1 5206.5 4993.7 5044.8 5123.0 5146.0 5149.2 4993.2 5056.3 5070.2 5112.6 5149.4 4240.6 5038.6 5038.7 5047.8 5111.2 5387.9 5398.0 5527.4 5543.2 5580.0 5897.7 5944.4 6026.0 6058.6 6109.3 6143.9 6146.4 6152.5 6154.1 6160.4 4230.9 5709.7 5715.1 5731.1 5736.9 6014.2 6080.7 6093.1 6117.2 6139.5 5883.5 5968.2 5972.5 5974.2 6010.8 6056.9 6097.3 6129.8 6130.0 6144.2 5858.9 5933.9 5969.6 6002.5 6023.5 4963.9 6065.8 6071.6 6077.5 6128.7 4668.4 4806.4 4808.4 4812.4 4858.6 4283.5 4288.7 4300.2 4380.7 4404.8 5534.4 5577.7 5605.1 5616.9 5630.7 6028.0 6085.6 6100.8 6106.1 6119.1 5553.4 5588.6 5593.3 5597.0 5599.3 4443.8 5267.2 5269.8 5278.4 5286.9 6094.8 6106.3 6106.4 6121.6 6127.0 5411.3 6039.1 6039.8 6060.2 6087.3 4727.8 5091.5 6160.8 6185.7 6186.7 4909.0 5119.2 5870.6 5870.7 5916.1 6052.5 6114.2 6134.9 6164.0 6170.4 6017.6 6021.1 6026.5 6031.2 6039.9 5661.7 5947.2 6008.6 6024.8 6039.6 5645.3 5672.6 5699.6 5800.2 5878.4 5970.5 5995.9 5995.9 5997.9 6010.9 5534.9 5830.8 5840.3 5887.6 5894.2 06:43:27 INFO - PROCESS | 1658 | 06:43:27 INFO - PROCESS | 1658 | [#1] ext.html Cycles:180 Average:70154.03 Median:40675.49 stddev:153974.66 (378.5%) stddev-sans-first:154317.68 06:43:27 INFO - PROCESS | 1658 | Values: 458.7 474.0 515.2 528.6 529.0 40000.8 41549.8 41737.6 41801.0 43356.9 35959.5 42136.0 42671.4 42877.6 42976.4 9440.2 9602.7 9628.2 9713.6 9751.0 9549.8 9569.3 9650.1 9664.3 9671.7 9594.0 9613.1 9653.7 9657.3 9702.0 8234.8 9599.7 9614.2 9624.8 9718.7 9552.8 9630.6 9643.0 9678.4 9684.7 40305.0 40634.0 40717.0 40754.8 40756.2 3310.7 3328.8 3333.1 3355.7 3361.5 27674.4 27751.9 27961.7 28149.7 28520.6 2786.8 3225.1 3243.5 3260.4 3335.6 471157.0 472474.6 473832.0 473839.0 474129.0 57946.0 58260.0 58288.4 58319.8 58336.0 61046.1 61196.1 61480.7 61501.7 61609.7 15484.2 15616.8 15829.7 15900.0 16085.9 10417.6 12855.9 12861.7 12897.6 13075.9 17332.2 17408.9 17543.8 17673.0 17703.9 6375.0 6557.6 6560.7 6577.7 6644.7 702.9 892.9 931.7 932.6 1046.9 25537.7 28107.0 28841.0 29555.8 30693.8 1050.8 1059.9 1135.5 1169.5 1192.7 15288.8 15538.3 15565.5 15582.1 16081.0 638707.0 639407.0 641299.0 642680.0 642886.0 57057.1 57580.4 58725.8 62686.1 62789.7 1118.2 1326.3 1356.9 1365.0 1370.0 30421.1 30829.7 30846.4 31170.7 31568.0 50775.7 51036.0 51048.0 51609.0 51969.0 597296.0 599374.0 600416.0 601120.0 601416.0 25879.6 25930.2 26017.5 26158.5 26511.5 37358.0 46580.3 46746.0 46929.8 46983.5 37835.9 39372.6 39384.6 39763.2 40110.0 32989.8 34075.1 38399.0 39729.4 39829.0 31632.0 37487.6 38044.2 38525.6 38994.6 33421.8 34005.5 34737.7 34839.0 34926.0 23911.8 24353.4 25074.2 25469.4 25961.7 06:43:27 INFO - PROCESS | 1658 | 06:43:27 INFO - PROCESS | 1658 | [#2] jquery.html Cycles:180 Average:32487.79 Median:346.09 stddev:93094.48 (26898.8%) stddev-sans-first:93324.32 06:43:27 INFO - PROCESS | 1658 | Values: 328.3 363.9 364.9 371.9 391.6 15096.9 15404.6 18431.5 18884.7 19775.7 16704.2 19313.7 19380.3 19620.4 20485.6 5664.1 6029.6 6034.9 6044.4 6049.5 5698.8 5909.0 5973.0 6024.5 6041.7 5119.0 5862.6 5968.7 5980.1 5989.8 5683.5 5887.6 5926.3 5928.1 5930.2 4454.9 5177.8 5180.3 5183.4 5190.1 24139.0 24242.9 24513.5 24525.4 24585.3 2256.8 2327.0 2414.6 2566.8 2847.5 14521.1 15189.8 15390.9 15412.0 15947.3 1781.5 1818.2 1874.2 1945.0 1973.9 114644.0 117112.2 117313.0 117580.0 118040.4 10569.8 10829.2 10898.9 11072.5 11262.4 13386.5 13704.1 13719.9 13733.2 13736.0 8200.9 8399.5 8505.3 8594.1 8637.0 8403.0 8471.6 8495.5 8668.5 8687.5 6497.1 6625.3 6636.4 6648.3 6745.3 1534.6 1812.5 1831.8 1857.6 1866.4 845.4 880.3 910.2 945.6 994.4 20833.7 21492.7 21804.2 21902.2 21936.3 913.2 936.7 955.7 1003.7 1011.4 8349.7 11573.9 11586.4 11620.0 11639.5 516237.0 558640.0 564529.2 565117.0 593766.0 61003.0 82981.2 102274.0 103235.0 104985.0 434.7 454.3 457.5 1057.5 1061.7 10329.3 10585.7 10767.3 10985.3 11041.4 44482.6 53257.0 53535.5 54584.7 56567.6 70400.0 77483.0 78137.0 78164.6 78789.6 6658.9 7821.8 7962.3 8002.8 8259.2 10178.0 10528.7 10867.7 11619.8 12559.1 10294.7 10467.4 10640.3 10815.2 10858.0 8152.5 8924.6 9172.8 10262.1 10615.2 8941.6 9647.6 10552.6 10862.6 10904.3 7842.8 7905.4 7992.5 8059.8 8104.8 9076.0 10585.3 10756.8 10789.0 10798.1 06:43:27 INFO - PROCESS | 1658 | 06:43:27 INFO - PROCESS | 1658 | [#3] mootools.html Cycles:180 Average:5515.47 Median:5022.77 stddev:3123.47 (62.2%) stddev-sans-first:3116.87 06:43:27 INFO - PROCESS | 1658 | Values: 1393.2 1472.9 1668.6 1800.6 1827.6 7877.8 8163.8 8324.0 8927.3 8942.0 8394.5 8688.0 8688.5 8789.1 8814.1 2183.7 2187.8 2214.6 2220.5 2223.3 2196.5 2220.7 2243.0 2250.4 2252.3 2244.8 2247.3 2255.2 2256.9 2263.6 2202.1 2208.4 2217.6 2224.9 2227.9 1916.8 2219.3 2229.2 2234.9 2247.1 8632.7 8776.2 8779.7 8785.1 8797.8 5020.9 5170.5 5178.0 5179.7 5196.2 3352.6 3357.6 3575.6 3576.5 3579.8 1040.9 1041.6 1062.4 1064.0 1073.6 10975.0 11286.1 11331.4 11334.1 11531.5 3803.8 3949.2 4118.7 4448.7 4477.6 8884.2 8952.3 9013.6 9026.0 9063.2 5130.8 5140.9 5141.6 5153.3 5155.3 4051.3 4335.8 4338.5 4783.9 4794.3 3536.4 3591.6 3594.6 3609.4 3699.0 1119.9 1122.4 1127.3 1127.7 1134.6 634.3 724.4 796.3 850.9 861.1 4693.6 4701.3 5359.8 5797.4 5829.2 891.9 910.8 960.7 961.8 991.9 3704.4 3823.4 3958.8 4015.8 4041.4 9733.4 10292.9 10527.1 10533.4 10579.0 9742.4 10372.3 10488.1 10497.2 10519.7 7835.4 7839.7 8095.5 8109.0 8115.6 4920.4 5630.9 5636.8 5654.8 5773.7 8885.8 9487.6 9737.3 9789.5 9852.0 9801.5 9943.3 9955.8 10010.6 10068.2 6858.5 7106.9 7187.7 7392.4 7507.4 8087.2 8216.8 8341.9 8346.6 8349.6 7206.7 7287.9 7295.1 7347.1 7449.5 7261.6 7283.2 7293.9 7305.3 7354.5 6823.1 6835.9 6907.9 6914.4 6919.2 4918.1 4927.3 4955.9 4970.0 4994.5 4737.9 4970.3 5024.7 5082.6 5099.2 06:43:27 INFO - PROCESS | 1658 | 06:43:27 INFO - PROCESS | 1658 | [#4] prototype.html Cycles:180 Average:4518.63 Median:5112.24 stddev:1424.48 (27.9%) stddev-sans-first:1392.72 06:43:27 INFO - PROCESS | 1658 | Values: 293.3 296.3 304.5 305.7 311.2 4804.7 5044.5 5165.8 5282.4 5438.4 4834.3 5089.0 5261.2 5267.6 5287.3 3605.9 4106.7 4123.6 4137.5 4157.3 3285.0 3438.4 3647.9 3910.2 4168.5 3052.8 3356.1 3490.6 3712.3 4060.3 3386.5 3502.4 3572.9 4041.4 4053.7 3121.6 3470.8 3567.0 3573.8 3595.4 4962.5 5040.1 5135.5 5137.1 5236.3 4210.4 4667.3 4678.3 4686.0 4698.6 4707.4 4832.7 5542.6 5563.4 5566.4 3296.5 3431.0 3941.2 3949.3 3991.8 4937.0 5803.4 5875.3 5890.9 5925.8 3428.5 3448.8 3727.4 3875.7 3892.3 3887.8 3914.3 3927.4 3966.9 3977.0 4113.8 4271.1 4580.5 4592.8 4609.3 5045.9 5513.0 5690.7 5708.2 5722.6 1118.3 1230.6 1297.2 1308.0 1344.5 881.7 890.2 895.8 901.2 913.6 4903.9 5231.8 5247.9 5254.5 5337.8 5575.9 5683.9 5714.7 5745.1 5932.9 4991.5 5010.4 5399.8 5400.9 5436.0 2543.4 2719.9 2869.5 2960.8 3071.0 5012.7 5160.7 5422.5 5628.9 5943.7 5489.5 5538.7 6027.5 6037.2 6060.3 4927.2 5344.8 5762.9 6055.3 6127.0 4912.3 5520.5 5562.9 5569.9 5617.6 5845.5 5846.5 5856.8 5867.1 5935.6 4679.5 5669.0 5710.3 5797.3 6079.1 3473.3 3837.6 3855.8 3885.4 3905.3 4990.0 5830.4 5880.0 5919.5 5958.0 4716.0 5395.6 5651.2 5657.4 5676.7 5554.2 5579.8 5686.5 5723.8 5724.7 4884.6 5237.8 5268.5 5449.6 5486.6 5587.7 5623.7 5639.4 5640.7 5683.6 4493.5 5247.9 5534.9 5537.8 5588.5 06:43:27 INFO - PROCESS | 1658 | 06:43:27 INFO - PROCESS | 1658 | [#5] yui.html Cycles:180 Average:24005.35 Median:3665.00 stddev:39164.41 (1068.6%) stddev-sans-first:39234.86 06:43:27 INFO - PROCESS | 1658 | Values: 601.1 697.6 729.6 736.0 765.5 12466.0 12696.0 14260.9 14438.9 14618.7 12896.7 13168.0 13175.6 13260.6 13312.2 803.0 823.1 827.9 828.1 828.9 656.8 675.3 802.7 817.1 826.6 863.4 867.8 872.8 877.9 878.3 751.6 872.3 874.2 874.5 875.5 647.5 648.5 649.5 650.4 653.2 13203.9 13356.7 13390.3 13392.4 13451.2 12637.6 13401.7 14243.0 14387.7 14721.9 9157.0 11736.8 11741.9 11844.5 12001.2 3706.9 3758.9 3768.5 3786.4 3892.8 112376.0 114288.1 114850.0 116005.0 117761.0 10926.2 10930.5 10971.8 10982.5 11369.0 22079.3 22267.4 22395.2 22425.2 22460.7 6424.1 6927.8 7504.1 7799.1 8219.3 4457.1 4479.5 4485.6 4499.8 4529.8 3494.8 3560.1 3605.8 3616.1 3623.1 641.2 644.5 644.9 660.2 663.5 640.8 643.0 654.1 654.3 659.8 9204.6 9309.0 9326.3 9517.2 9620.2 552.4 585.2 648.2 659.8 696.0 4554.9 4673.0 4675.9 4704.0 4757.5 95733.5 121382.4 127465.4 155134.0 160217.0 109620.0 110361.2 133210.0 143397.0 146819.0 101013.5 121191.0 122289.4 124467.8 126106.0 8513.7 8543.4 8848.6 9044.3 9199.5 46961.8 48488.8 51501.2 57997.0 62287.4 72118.6 91247.2 91486.0 92071.5 92241.0 11434.0 11531.0 11655.4 11830.4 11858.1 12258.9 12379.6 12443.1 12486.2 12865.4 11729.7 11961.5 11979.1 12320.8 12358.2 11371.9 11422.4 11703.2 11932.3 12323.2 11527.5 11574.0 11575.7 11642.4 11923.0 9422.8 9794.4 10000.9 10075.9 10504.9 10443.3 10802.4 11370.5 11487.9 11560.8 06:43:27 INFO - PROCESS | 1658 | -------- Summary: end -------- 06:43:27 INFO - PROCESS | 1658 | 06:43:28 INFO - TEST-INFO | 1658: exit 0 06:43:28 INFO - TEST-OK | dromaeo_css | took 1115717ms 06:43:28 INFO - TEST-START | kraken 06:43:28 INFO - operating with platform_type : mac_ 06:43:28 INFO - Initialising browser for kraken test... 06:43:28 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/tmpldw8oc/profile http://localhost:49277/getInfo.html) 06:43:31 INFO - PROCESS | 1666 | 2016-10-12 06:43:31.030 plugin-container[1667:10612] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4643, name = 'com.apple.tsm.portname' 06:43:31 INFO - PROCESS | 1666 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:43:31 INFO - PROCESS | 1666 | 2016-10-12 06:43:31.032 plugin-container[1667:10612] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 06:43:31 INFO - PROCESS | 1666 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:43:31 INFO - PROCESS | 1666 | 2016-10-12 06:43:31.032 plugin-container[1667:10612] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 06:43:31 INFO - PROCESS | 1666 | __metrics Screen width/height:1600/1200 06:43:31 INFO - PROCESS | 1666 | colorDepth:24 06:43:31 INFO - PROCESS | 1666 | Browser inner width/height: 1024/689 06:43:31 INFO - PROCESS | 1666 | __metrics 06:43:31 ERROR - PROCESS | 1666 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3083: TypeError: this.tabs is undefined 06:43:31 INFO - TEST-INFO | 1666: exit 0 06:43:31 INFO - Browser initialized. 06:43:31 INFO - Running cycle 1/1 for kraken test... 06:43:31 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/tmpldw8oc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:43:34 INFO - PROCESS | 1668 | 2016-10-12 06:43:34.182 plugin-container[1669:10729] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x872f, name = 'com.apple.tsm.portname' 06:43:34 INFO - PROCESS | 1668 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:43:34 INFO - PROCESS | 1668 | 2016-10-12 06:43:34.182 plugin-container[1669:10729] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e0b, name = 'com.apple.CFPasteboardClient' 06:43:34 INFO - PROCESS | 1668 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:43:34 INFO - PROCESS | 1668 | 2016-10-12 06:43:34.182 plugin-container[1669:10729] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 06:43:43 INFO - PROCESS | 1668 | RSS: Main: 239112192 06:43:43 INFO - PROCESS | 1668 | 06:43:47 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection) 06:43:48 INFO - PROCESS | 1668 | RSS: Main: 252850176 06:43:48 INFO - PROCESS | 1668 | 06:43:50 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-dft) 06:43:51 INFO - PROCESS | 1668 | RSS: Main: 261275648 06:43:51 INFO - PROCESS | 1668 | 06:43:54 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-fft) 06:43:55 INFO - PROCESS | 1668 | RSS: Main: 261406720 06:43:55 INFO - PROCESS | 1668 | 06:43:57 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator) 06:43:57 INFO - PROCESS | 1668 | RSS: Main: 263487488 06:43:57 INFO - PROCESS | 1668 | 06:43:59 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:44:00 INFO - PROCESS | 1668 | RSS: Main: 263766016 06:44:00 INFO - PROCESS | 1668 | 06:44:03 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom) 06:44:03 INFO - PROCESS | 1668 | RSS: Main: 263901184 06:44:03 INFO - PROCESS | 1668 | 06:44:07 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate) 06:44:07 INFO - PROCESS | 1668 | RSS: Main: 264097792 06:44:07 INFO - PROCESS | 1668 | 06:44:10 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial) 06:44:11 INFO - PROCESS | 1668 | RSS: Main: 264200192 06:44:11 INFO - PROCESS | 1668 | 06:44:12 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:44:13 INFO - PROCESS | 1668 | RSS: Main: 263958528 06:44:13 INFO - PROCESS | 1668 | 06:44:15 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:44:16 INFO - PROCESS | 1668 | RSS: Main: 264089600 06:44:16 INFO - PROCESS | 1668 | 06:44:18 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:44:18 INFO - PROCESS | 1668 | RSS: Main: 264568832 06:44:18 INFO - PROCESS | 1668 | 06:44:21 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:44:22 INFO - PROCESS | 1668 | RSS: Main: 264597504 06:44:22 INFO - PROCESS | 1668 | 06:44:25 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:44:26 INFO - PROCESS | 1668 | RSS: Main: 264495104 06:44:26 INFO - PROCESS | 1668 | 06:44:27 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49277/tests/kraken/driver.html?testName=ai-astar) 06:44:28 INFO - PROCESS | 1668 | RSS: Main: 265854976 06:44:28 INFO - PROCESS | 1668 | 06:44:28 INFO - PROCESS | 1668 | __start_tp_report 06:44:28 INFO - PROCESS | 1668 | _x_x_mozilla_page_load 06:44:28 INFO - PROCESS | 1668 | _x_x_mozilla_page_load_details 06:44:28 INFO - PROCESS | 1668 | |i|pagename|runs| 06:44:28 INFO - PROCESS | 1668 | |0;ai-astar;106;117;116;117;118;118;137;173;173;118 06:44:28 INFO - PROCESS | 1668 | |1;audio-beat-detection;148;116;112;153;115;115;116;119;145;116 06:44:28 INFO - PROCESS | 1668 | |2;audio-dft;199;212;214;207;200;197;201;199;207;194 06:44:28 INFO - PROCESS | 1668 | |3;audio-fft;77;58;60;84;48;59;63;86;105;81 06:44:28 INFO - PROCESS | 1668 | |4;audio-oscillator;89;70;85;74;69;70;88;70;71;114 06:44:28 INFO - PROCESS | 1668 | |5;imaging-gaussian-blur;110;87;90;122;90;87;94;100;98;107 06:44:28 INFO - PROCESS | 1668 | |6;imaging-darkroom;126;107;159;118;101;97;137;101;136;150 06:44:28 INFO - PROCESS | 1668 | |7;imaging-desaturate;134;116;90;90;91;89;90;89;92;90 06:44:28 INFO - PROCESS | 1668 | |8;json-parse-financial;57;57;54;59;58;58;58;56;55;55 06:44:28 INFO - PROCESS | 1668 | |9;json-stringify-tinderbox;69;76;86;112;73;58;97;101;64;64 06:44:28 INFO - PROCESS | 1668 | |10;stanford-crypto-aes;98;82;83;102;85;88;90;88;96;110 06:44:28 INFO - PROCESS | 1668 | |11;stanford-crypto-ccm;160;146;140;149;155;145;167;157;185;147 06:44:28 INFO - PROCESS | 1668 | |12;stanford-crypto-pbkdf2;173;172;172;174;174;186;230;200;174;177 06:44:28 INFO - PROCESS | 1668 | |13;stanford-crypto-sha256-iterative;71;69;69;72;82;87;84;88;74;71 06:44:28 INFO - PROCESS | 1668 | __end_tp_report 06:44:28 INFO - PROCESS | 1668 | __start_cc_report 06:44:28 INFO - PROCESS | 1668 | _x_x_mozilla_cycle_collect,999 06:44:28 INFO - PROCESS | 1668 | __end_cc_report 06:44:28 INFO - PROCESS | 1668 | __startTimestamp1476279868237__endTimestamp 06:44:28 INFO - PROCESS | 1668 | 06:44:28 INFO - PROCESS | 1668 | ------- Summary: start ------- 06:44:28 INFO - PROCESS | 1668 | Number of tests: 14 06:44:28 INFO - PROCESS | 1668 | 06:44:28 INFO - PROCESS | 1668 | [#0] ai-astar Cycles:10 Average:129.30 Median:118.00 stddev:24.23 (20.5%) stddev-sans-first:24.19 06:44:28 INFO - PROCESS | 1668 | Values: 106.0 117.0 116.0 117.0 118.0 118.0 137.0 173.0 173.0 118.0 06:44:28 INFO - PROCESS | 1668 | 06:44:28 INFO - PROCESS | 1668 | [#1] audio-beat-detection Cycles:10 Average:125.50 Median:117.50 stddev:16.19 (13.8%) stddev-sans-first:14.98 06:44:28 INFO - PROCESS | 1668 | Values: 148.0 116.0 112.0 153.0 115.0 115.0 116.0 119.0 145.0 116.0 06:44:28 INFO - PROCESS | 1668 | 06:44:28 INFO - PROCESS | 1668 | [#2] audio-dft Cycles:10 Average:203.00 Median:204.00 stddev:6.63 (3.3%) stddev-sans-first:6.88 06:44:28 INFO - PROCESS | 1668 | Values: 199.0 212.0 214.0 207.0 200.0 197.0 201.0 199.0 207.0 194.0 06:44:28 INFO - PROCESS | 1668 | 06:44:28 INFO - PROCESS | 1668 | [#3] audio-fft Cycles:10 Average:72.10 Median:70.00 stddev:17.32 (24.7%) stddev-sans-first:18.28 06:44:28 INFO - PROCESS | 1668 | Values: 77.0 58.0 60.0 84.0 48.0 59.0 63.0 86.0 105.0 81.0 06:44:28 INFO - PROCESS | 1668 | 06:44:28 INFO - PROCESS | 1668 | [#4] audio-oscillator Cycles:10 Average:80.00 Median:72.50 stddev:14.39 (19.9%) stddev-sans-first:14.89 06:44:28 INFO - PROCESS | 1668 | Values: 89.0 70.0 85.0 74.0 69.0 70.0 88.0 70.0 71.0 114.0 06:44:28 INFO - PROCESS | 1668 | 06:44:28 INFO - PROCESS | 1668 | [#5] imaging-gaussian-blur Cycles:10 Average:98.50 Median:88.50 stddev:11.49 (13.0%) stddev-sans-first:11.41 06:44:28 INFO - PROCESS | 1668 | Values: 110.0 87.0 90.0 122.0 90.0 87.0 94.0 100.0 98.0 107.0 06:44:28 INFO - PROCESS | 1668 | 06:44:28 INFO - PROCESS | 1668 | [#6] imaging-darkroom Cycles:10 Average:123.20 Median:136.50 stddev:21.92 (16.1%) stddev-sans-first:23.22 06:44:28 INFO - PROCESS | 1668 | Values: 126.0 107.0 159.0 118.0 101.0 97.0 137.0 101.0 136.0 150.0 06:44:28 INFO - PROCESS | 1668 | 06:44:28 INFO - PROCESS | 1668 | [#7] imaging-desaturate Cycles:10 Average:97.10 Median:90.00 stddev:15.33 (17.0%) stddev-sans-first:8.67 06:44:28 INFO - PROCESS | 1668 | Values: 134.0 116.0 90.0 90.0 91.0 89.0 90.0 89.0 92.0 90.0 06:44:28 INFO - PROCESS | 1668 | 06:44:28 INFO - PROCESS | 1668 | [#8] json-parse-financial Cycles:10 Average:56.70 Median:57.50 stddev:1.64 (2.8%) stddev-sans-first:1.73 06:44:28 INFO - PROCESS | 1668 | Values: 57.0 57.0 54.0 59.0 58.0 58.0 58.0 56.0 55.0 55.0 06:44:28 INFO - PROCESS | 1668 | 06:44:28 INFO - PROCESS | 1668 | [#9] json-stringify-tinderbox Cycles:10 Average:80.00 Median:71.00 stddev:18.17 (25.6%) stddev-sans-first:18.83 06:44:28 INFO - PROCESS | 1668 | Values: 69.0 76.0 86.0 112.0 73.0 58.0 97.0 101.0 64.0 64.0 06:44:28 INFO - PROCESS | 1668 | 06:44:28 INFO - PROCESS | 1668 | [#10] stanford-crypto-aes Cycles:10 Average:92.20 Median:88.00 stddev:9.08 (10.3%) stddev-sans-first:9.38 06:44:28 INFO - PROCESS | 1668 | Values: 98.0 82.0 83.0 102.0 85.0 88.0 90.0 88.0 96.0 110.0 06:44:28 INFO - PROCESS | 1668 | 06:44:28 INFO - PROCESS | 1668 | [#11] stanford-crypto-ccm Cycles:10 Average:155.10 Median:156.00 stddev:13.25 (8.5%) stddev-sans-first:13.93 06:44:28 INFO - PROCESS | 1668 | Values: 160.0 146.0 140.0 149.0 155.0 145.0 167.0 157.0 185.0 147.0 06:44:28 INFO - PROCESS | 1668 | 06:44:28 INFO - PROCESS | 1668 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.20 Median:175.50 stddev:18.64 (10.6%) stddev-sans-first:19.40 06:44:28 INFO - PROCESS | 1668 | Values: 173.0 172.0 172.0 174.0 174.0 186.0 230.0 200.0 174.0 177.0 06:44:28 INFO - PROCESS | 1668 | 06:44:28 INFO - PROCESS | 1668 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.70 Median:78.00 stddev:7.66 (9.8%) stddev-sans-first:7.84 06:44:28 INFO - PROCESS | 1668 | Values: 71.0 69.0 69.0 72.0 82.0 87.0 84.0 88.0 74.0 71.0 06:44:28 INFO - PROCESS | 1668 | -------- Summary: end -------- 06:44:28 INFO - PROCESS | 1668 | 06:44:29 INFO - TEST-INFO | 1668: exit 0 06:44:29 INFO - TEST-OK | kraken | took 60761ms 06:44:29 INFO - SUITE-END | took 1176s 06:44:29 INFO - Completed test suite (00:19:36) 06:44:29 INFO - javascript benchmark 06:44:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7141.824066769632, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3285.40862644724, 3328.5672862527867, 3340.549025881506, 3340.5991281046277, 3361.3781450431657, 5399.217113518537, 5517.862053448661, 5533.501984821375, 5542.63972841765, 5601.075822489294, 4844.055409195208, 5406.621536492447, 5506.421825708303, 5553.305836770403, 5607.663540187592, 4991.0, 5021.648484606079, 5129.281900533928, 5139.640225184238, 5170.819021334254, 5015.949840501603, 5173.715445650488, 5201.661891977028, 5202.089634313998, 5206.45332240115, 4993.725345106018, 5044.798208071673, 5123.001014802115, 5146.0, 5149.150390185615, 4993.201087825967, 5056.342675452204, 5070.188769796815, 5112.642115051948, 5149.356330458692, 4240.554741752133, 5038.5969122470115, 5038.748062596892, 5047.772850221749, 5111.1566591512355, 5387.892242155174, 5398.00136974657, 5527.364353099365, 5543.223948647193, 5579.972100139514, 5897.675627840467, 5944.405559444064, 6026.0, 6058.636481811105, 6109.2528441424865, 6143.907841382383, 6146.385361463863, 6152.507799376039, 6154.107654390088, 6160.414760597736, 4230.936535951963, 5709.65742055478, 5715.085586306171, 5731.083026715705, 5736.913946290809, 6014.1580178775, 6080.665563394055, 6093.081586421939, 6117.2184870185665, 6139.492138333381, 5883.529317654577, 5968.1942937703725, 5972.462478376967, 5974.1934838796205, 6010.759569617254, 6056.909146362808, 6097.298810636834, 6129.754809807558, 6130.0, 6144.201253837062, 5858.8535286617325, 5933.851653708605, 5969.582129250911, 6002.459778619946, 6023.45788879003, 4963.875903102379, 6065.8180254592435, 6071.635701857815, 6077.483413909778, 6128.724207410677, 4668.39310889589, 4806.447258565309, 4808.35087263215, 4812.374391329105, 4858.6356023298395, 4283.507396649363, 4288.699791014599, 4300.204462174508, 4380.737155770664, 4404.823807047682, 5534.391216966131, 5577.6932268724795, 5605.131204663284, 5616.887662246814, 5630.746616402272, 6027.975244208407, 6085.6348619083, 6100.816975490742, 6106.084087386838, 6119.112728654321, 5553.416891226444, 5588.580856435702, 5593.300837395325, 5597.0, 5599.32808063035, 4443.822247110079, 5267.183586544092, 5269.841904742864, 5278.392984806719, 5286.9471305287225, 6094.8171554853425, 6106.339326077157, 6106.399996025858, 6121.57491608479, 6127.0, 5411.323584551931, 6039.094135879654, 6039.758409663565, 6060.151578779062, 6087.269527656709, 4727.834525791718, 5091.465396133501, 6160.7535698571555, 6185.690715464299, 6186.721597528032, 4908.950910490849, 5119.155339368963, 5870.589058765845, 5870.735816888165, 5916.083007133901, 6052.515798736003, 6114.205153330038, 6134.907976380268, 6164.013757798731, 6170.413810687977, 6017.608855424383, 6021.126936594257, 6026.548008899263, 6031.215941927521, 6039.909401358896, 5661.688607126483, 5947.226860508279, 6008.579399441997, 6024.849378765566, 6039.63762174271, 5645.322561292671, 5672.631278966854, 5699.5725320600295, 5800.24596802413, 5878.382769809108, 5970.462658360769, 5995.850103747442, 5995.940040599713, 5997.850053748692, 6010.939890601038, 5534.889302213853, 5830.766769329349, 5840.2991641003355, 5887.646741195542, 5894.233749612523], "value": 5506.531098043867, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [458.68121655449477, 473.9549742774435, 515.1962937817005, 528.5612941258754, 529.0450736420761, 40000.799996000016, 41549.79225103878, 41737.58262417375, 41800.95497612561, 43356.91607709801, 35959.4606080909, 42136.0, 42671.35992960108, 42877.57122428783, 42976.35535466971, 9440.19758320542, 9602.663906763264, 9628.229741620653, 9713.562889669982, 9750.951245243763, 9549.809003819919, 9569.282303827205, 9650.08324209199, 9664.323497355188, 9671.70984870455, 9594.04059594042, 9613.086756758097, 9653.662121825737, 9657.275704322205, 9702.0, 8234.752957411287, 9599.664011759554, 9614.230861531096, 9624.759381015461, 9718.70843874685, 9552.808943821085, 9630.614775408976, 9642.951785241099, 9678.370905891165, 9684.70945871625, 40305.0, 40633.98415039618, 40717.0, 40754.796226018974, 40756.18487630261, 3310.668933106694, 3328.766986310935, 3333.1333853198103, 3355.681210285019, 3361.5461912641726, 27674.446511069866, 27751.861240693666, 27961.720382796117, 28149.718502814914, 28520.572191417144, 2786.763125134366, 3225.0808519572042, 3243.5459035735016, 3260.3642289753507, 3335.5663763710804, 471157.0, 472474.6376268131, 473832.0, 473839.0, 474129.0, 57946.0, 58260.0, 58288.41711582915, 58319.833603327694, 58336.0, 61046.08430873541, 61196.082058769156, 61480.69259653673, 61501.69249153726, 61609.69195153996, 15484.225788710519, 15616.76574851378, 15829.68340633181, 15900.045997239971, 16085.919570402073, 10417.583296668048, 12855.935720321339, 12861.678458038625, 12897.613071607866, 13075.869241307655, 17332.220050097774, 17408.912955435142, 17543.807024121983, 17673.027983461034, 17703.911480442774, 6374.968125159345, 6557.573697731775, 6560.704768285439, 6577.6711164441585, 6644.734210631617, 702.8980797784293, 892.9330300227509, 931.6878845586668, 932.6455946740331, 1046.895310468947, 25537.744622553535, 28107.016254430997, 28841.0, 29555.817767289496, 30693.846530767205, 1050.753073027838, 1059.9417032063157, 1135.5287555664472, 1169.502961241486, 1192.6899006258436, 15288.847111528965, 15538.300776465087, 15565.533034008999, 15582.06507609547, 16081.0, 638707.0, 639407.0, 641299.0, 642680.0, 642886.0, 57057.14414283789, 57580.42419575751, 58725.825483490094, 62686.0597091044, 62789.744205116556, 1118.2060736876747, 1326.3103186343048, 1356.87109724576, 1365.0308281120515, 1369.9794503082262, 30421.087367379016, 30829.69170308358, 30846.383072338875, 31170.68829311678, 31568.0, 50775.746121269156, 51036.0, 51048.0, 51608.96782064413, 51969.0, 597296.0, 599374.003129999, 600416.0, 601119.9944000252, 601416.0, 25879.611805823304, 25930.22209333723, 26017.479650407266, 26158.476830462903, 26511.469770604093, 37358.0, 46580.30129548127, 46746.0, 46929.765351173024, 46983.53016469791, 37835.86492405232, 39372.60627393689, 39384.6061539381, 39763.20473590454, 40110.0, 32989.83505082459, 34075.14812129716, 38399.04002399962, 39729.40405893972, 39829.00427489336, 31632.0, 37487.62512374841, 38044.23911521809, 38525.6147438522, 38994.6100538991, 33421.83289083539, 34005.48991765076, 34737.65262347445, 34839.0, 34925.9522214334, 23911.760882390954, 24353.39116522101, 25074.24777256685, 25469.3632659185, 25961.740382595934], "value": 19661.738511846143, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.3334830294503, 363.8508211633231, 364.92883887641904, 371.8809980806141, 391.6416478921787, 15096.943213974999, 15404.613584777368, 18431.539211519717, 18884.716729249056, 19775.703364449546, 16704.164791760395, 19313.71029434556, 19380.321688740896, 19620.411387658394, 20485.590288194227, 5664.1220610805185, 6029.60807547508, 6034.909476357836, 6044.365341639131, 6049.546284028694, 5698.8005419810315, 5909.0, 5973.014452615335, 6024.548158888079, 6041.697915104249, 5119.001794650045, 5862.589618726691, 5968.701564921758, 5980.073088671263, 5989.8203053908455, 5683.54531637468, 5887.646741195542, 5926.348101708809, 5928.110783382484, 5930.229070220844, 4454.864009677544, 5177.844664660066, 5180.300659410969, 5183.352080989876, 5190.117679994372, 24139.0, 24242.878785606135, 24513.509729805482, 24525.38686532833, 24585.262442126765, 2256.763039880805, 2327.0459111764267, 2414.637804329347, 2566.781823545001, 2847.458982793283, 14521.12873227599, 15189.848101518954, 15390.923045384814, 15412.0, 15947.282372293159, 1781.4833698227499, 1818.163644723429, 1874.240932422371, 1945.0177660281468, 1973.8716983396034, 114644.0, 117112.24331634947, 117313.0, 117580.0, 118040.40979795046, 10569.841452378221, 10829.187810914213, 10898.945505272422, 11072.501737421835, 11262.436878156223, 13386.531471398454, 13704.10923290003, 13719.862801372059, 13733.176009439465, 13735.96980226487, 8200.876986845202, 8399.538025408661, 8505.31957443403, 8594.140585941355, 8637.0, 8402.957985210034, 8471.618777155043, 8495.490270583785, 8668.523231222343, 8687.478751274944, 6497.122888410098, 6625.337466253336, 6636.369544893324, 6648.301928297556, 6745.258021617618, 1534.6010037390135, 1812.5015620704412, 1831.7710286214224, 1857.5541869951114, 1866.3561071430336, 845.3997661660167, 880.3309484791605, 910.2308549275851, 945.645382981382, 994.3642707745718, 20833.68749468759, 21492.677609835864, 21804.236851710113, 21902.23342183016, 21936.341909742732, 913.1735779119907, 936.7096200177966, 955.7419496735843, 1003.6938733686296, 1011.438651548383, 8349.749507514784, 11573.942130289463, 11586.420678966018, 11619.95420412167, 11639.53441862316, 516237.0, 558640.0, 564529.2489608817, 565117.0, 593766.0, 61003.0, 82981.17018829855, 102274.0, 103235.0, 104984.95015049905, 434.7304671103936, 454.3094496365506, 457.5150340638933, 1057.5241141486363, 1061.686802393296, 10329.29566621529, 10585.671152346471, 10767.300125491818, 10985.340879546933, 11041.447927603427, 44482.55517444784, 53257.0, 53535.46464535305, 54584.72707636436, 56567.58581035507, 70400.0, 77483.0, 78137.0, 78164.60917695375, 78789.60605196937, 6658.866822663616, 7821.765347039598, 7962.32320252785, 8002.759917202493, 8259.174082591693, 10178.0, 10528.736781580521, 10867.673969780919, 11619.767604648028, 12559.120861539604, 10294.742631433974, 10467.371957682564, 10640.255182137485, 10815.24293299493, 10858.0, 8152.470089444168, 8924.553772311489, 9172.770680733034, 10262.076413122855, 10615.1507879371, 8941.597628106621, 9647.565859536197, 10552.577896884346, 10862.619808306672, 10904.291221070605, 7842.843143137219, 7905.367570594453, 7992.480488768211, 8059.798505037421, 8104.79738006531, 9075.954620227121, 10585.311954722918, 10756.83864742045, 10789.0, 10798.082163015917], "value": 9172.628886298147, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1393.2337214532008, 1472.9410823567057, 1668.6245594741185, 1800.5678637127094, 1827.6436094961489, 7877.80305492363, 8163.795905102375, 8324.0, 8927.28581713463, 8942.0, 8394.538300393477, 8688.0, 8688.478691278528, 8789.121087891208, 8814.118588141182, 2183.716116904808, 2187.814035806958, 2214.6124428225075, 2220.4781876259067, 2223.266322113707, 2196.527746534495, 2220.678001689754, 2243.046705150313, 2250.4036430345973, 2252.256755270757, 2244.7755224477505, 2247.3370355745014, 2255.154317131076, 2256.8645881247094, 2263.569921714877, 2202.064122747826, 2208.392692009694, 2217.6230040893006, 2224.8776317302622, 2227.866328020324, 1916.7987361327, 2219.3341997400876, 2229.175205174096, 2234.944126396853, 2247.1460844878843, 8632.65469381224, 8776.210141087333, 8779.692710755093, 8785.121487851227, 8797.824043519095, 5020.874478138039, 5170.508801663874, 5178.042062218502, 5179.741012949337, 5196.168613021899, 3352.6312105668358, 3357.6306606273292, 3575.6424357564297, 3576.499290099388, 3579.7673151245344, 1040.921930855189, 1041.5989843910074, 1062.4369084385212, 1063.9680809575725, 1073.608133031438, 10975.0, 11286.097112231002, 11331.37677427741, 11334.149938754626, 11531.48108335127, 3803.7717736935874, 3949.19041596472, 4118.670506359484, 4448.733076015449, 4477.597016268552, 8884.200421962054, 8952.328575356874, 9013.63945442175, 9025.954870225607, 9063.184313411824, 5130.846074617767, 5140.922886156711, 5141.5886729061585, 5153.2785410042625, 5155.278261043457, 4051.331530297527, 4335.761533115646, 4338.501072376654, 4783.880402989953, 4794.256890182028, 3536.41649127891, 3591.569011718558, 3594.6225646307284, 3609.4224924012033, 3699.0, 1119.8880111988735, 1122.354646078508, 1127.312339472921, 1127.6729748373043, 1134.597217987619, 634.2990994950513, 724.4204636290946, 796.3151689546985, 850.9363295880149, 861.0743450790426, 4693.647976401783, 4701.318308845198, 5359.812406565751, 5797.391273916262, 5829.183914252008, 891.9286457083417, 910.8132832769267, 960.6925783749273, 961.8124465729255, 991.8809742830762, 3704.4258139988347, 3823.3882578787816, 3958.802059896994, 4015.7992100394863, 4041.413994970713, 9733.367331123454, 10292.948535257276, 10527.052565269163, 10533.420661863518, 10579.047885690325, 9742.366746161477, 10372.27394082407, 10488.108510776518, 10497.160227181806, 10519.737006574744, 7835.373170146375, 7839.725609603751, 8095.502332068586, 8108.999999999882, 8115.634796434175, 4920.360353154067, 5630.859228519156, 5636.802711905064, 5654.830355089354, 5773.672055427338, 8885.822283554164, 9487.573059212215, 9737.318387712792, 9789.46157961319, 9851.950740246253, 9801.509924503604, 9943.30396872212, 9955.751106222402, 10010.599576016877, 10068.194544436574, 6858.5199036067, 7106.893396599158, 7187.676554554953, 7392.4086073115095, 7507.399408047452, 8087.150849160754, 8216.753497395088, 8341.874871876806, 8346.62440190205, 8349.582520874053, 7206.747763828241, 7287.927120728725, 7295.088113985752, 7347.08161479815, 7449.515781474403, 7261.6006119663925, 7283.198848126808, 7293.890591641236, 7305.305995930378, 7354.521956072838, 6823.078884350549, 6835.93164068353, 6907.930920690729, 6914.377706006484, 6919.169699635874, 4918.114739346952, 4927.310176575211, 4955.851324460272, 4969.975150124371, 4994.4755800640405, 4737.928931066106, 4970.254461830755, 5024.673396229234, 5082.618803589819, 5099.209622508517], "value": 4405.4662910857205, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [293.2975523620929, 296.27117291463, 304.5492670847147, 305.7141572629593, 311.2328111205877, 4804.71171729696, 5044.495550444954, 5165.767540460679, 5282.366116066068, 5438.395673276383, 4834.323194752737, 5088.974555127219, 5261.184516399964, 5267.551423358578, 5287.28621636079, 3605.9098522536883, 4106.650934670549, 4123.628873401393, 4137.482814648169, 4157.3140431828715, 3285.0, 3438.363902678, 3647.908802279951, 3910.1788624388914, 4168.499780026401, 3052.8320942348164, 3356.127406874206, 3490.616032236452, 3712.2575484903127, 4060.2894493463673, 3386.458166693342, 3502.390718914425, 3572.857085716594, 4041.3533834586324, 4053.716239863211, 3121.59419275495, 3470.7917524948584, 3566.982165089184, 3573.767705099186, 3595.352836489431, 4962.503749625044, 5040.143175660147, 5135.512126348029, 5137.12668846297, 5236.324376199617, 4210.3684447332835, 4667.346571479996, 4678.274867395559, 4686.0, 4698.553637404441, 4707.364505791708, 4832.73419961902, 5542.612017158801, 5563.415841336682, 5566.359868615121, 3296.5055241713935, 3430.953559164479, 3941.2314598653275, 3949.3483575210057, 3991.7604943703473, 4936.950630493721, 5803.448672376117, 5875.2949646042325, 5890.852728681774, 5925.762969481216, 3428.468587368962, 3448.827558622059, 3727.415848264531, 3875.701639950592, 3892.2799282132896, 3887.814216663888, 3914.3149948758855, 3927.3912543555793, 3966.861159859391, 3976.9602303977167, 4113.835446582103, 4271.081717430768, 4580.519045500175, 4592.839250626212, 4609.331646911246, 5045.8738531537, 5513.0, 5690.6870122142855, 5708.229389032511, 5722.628029178173, 1118.278710231896, 1230.56930074475, 1297.195738642048, 1308.0, 1344.536135033412, 881.7266647339345, 890.172139909877, 895.8029233568604, 901.2249465459699, 913.6254135804421, 4903.901921961612, 5231.8168864089575, 5247.927068807876, 5254.527092561688, 5337.825678350757, 5575.944240557624, 5683.943160568341, 5714.714264286769, 5745.052066409079, 5932.940670593325, 4991.450940396553, 5010.41963388855, 5399.784008639689, 5400.91898621521, 5435.994341046919, 2543.376872666209, 2719.9184024479296, 2869.483492971285, 2960.8371539565533, 3070.9539356909663, 5012.749362531858, 5160.690358578498, 5422.457754224546, 5628.943710562842, 5943.732532036069, 5489.478499542537, 5538.695371754592, 6027.48766354856, 6037.18498002764, 6060.303165091492, 4927.236278376858, 5344.781915505099, 5762.8795411281135, 6055.273367195965, 6126.969365153146, 4912.336834527436, 5520.475554822286, 5562.9443705564045, 5569.944300557105, 5617.634853734658, 5845.532357411482, 5846.532277417711, 5856.795012174553, 5867.090600956859, 5935.614185077956, 4679.461861885927, 5669.0, 5710.2576665033275, 5797.275280618102, 6079.1185278133535, 3473.305338932173, 3837.6162383762517, 3855.807209639563, 3885.4171874217964, 3905.297046531538, 4989.950100498949, 5830.358660547252, 5880.0, 5919.526437885045, 5958.0, 4715.976420118015, 5395.622306438669, 5651.15232715096, 5657.43425657431, 5676.7161641918565, 5554.166874968787, 5579.776808927598, 5686.545076393796, 5723.771049157987, 5724.685142317046, 4884.633652476007, 5237.81667641646, 5268.473152684701, 5449.6375906023495, 5486.588505862156, 5587.69267690281, 5623.690697011703, 5639.392773059658, 5640.746166422603, 5683.60214784961, 4493.460784705856, 5247.947520524898, 5534.920690465482, 5537.7784888604, 5588.469095435927], "value": 4063.0531499733993, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [601.0713447723267, 697.5535657179403, 729.5693363096856, 735.9595222262777, 765.4871236271697, 12466.0, 12695.98432125429, 14260.857391426083, 14438.855611443882, 14618.707625847477, 12896.677583060427, 13168.0, 13175.604731858035, 13260.602181934557, 13312.20126792393, 802.9518228906255, 823.0658202939646, 827.8799574061758, 828.0891019878115, 828.8963879515061, 656.8259411256021, 675.304436430475, 802.6749166587513, 817.1379194949326, 826.557791581504, 863.3567991846083, 867.7743786615463, 872.7905302727363, 877.9385443018991, 878.3456325037823, 751.5941391648503, 872.3239489395705, 874.1695389380083, 874.4753148111146, 875.5097145598485, 647.5014239035916, 648.4747354642755, 649.4706813946666, 650.3756393861898, 653.183520599251, 13203.933980330037, 13356.73286534264, 13390.330483475886, 13392.397342119628, 13451.192928424325, 12637.557685481055, 13401.66495837612, 14243.0, 14387.71224575513, 14721.92639036798, 9157.025287745933, 11736.823947640793, 11741.941290293495, 11844.526218951232, 12001.154435620314, 3706.9073273168387, 3758.906027349311, 3768.4724138620613, 3786.4320351947154, 3892.785896775676, 112376.0, 114288.14279642992, 114850.0, 116005.0, 117761.0, 10926.235163538635, 10930.508127134299, 10971.83542246867, 10982.505787239594, 11369.0, 22079.33761987143, 22267.443313917283, 22395.21616743406, 22425.21511747081, 22460.663090053662, 6424.13274207976, 6927.826804329932, 7504.137024242173, 7799.064112306446, 8219.301359384519, 4457.086297309044, 4479.529649386767, 4485.573870482299, 4499.775011249424, 4529.796159172779, 3494.759360427063, 3560.0565850049757, 3605.8197090145386, 3616.0959760059986, 3623.0942264433893, 641.2017038786647, 644.4747530762413, 644.932282110381, 660.207750699163, 663.4592806862488, 640.7533099756535, 642.9905049073004, 654.107143748789, 654.3325807676239, 659.8185498987817, 9204.63181472747, 9308.95345523268, 9326.300527460331, 9517.23862091031, 9620.230381569458, 552.3675391676508, 585.2128886647538, 648.2091847945499, 659.7756762700704, 695.9838635592092, 4554.931676024862, 4673.018666080161, 4675.906481870412, 4704.0, 4757.476677565534, 95733.52133239289, 121382.39308803399, 127465.36267318604, 155134.0, 160217.0, 109620.0, 110361.24096897482, 133210.0, 143397.0, 146819.0, 101013.49493252634, 121191.0, 122289.38855305666, 124467.75532244742, 126106.0, 8513.659453621785, 8543.40196186261, 8848.64605415802, 9044.321675874204, 9199.470145709716, 46961.76519117383, 48488.757556212, 51501.227481588554, 57997.0, 62287.37712622816, 72118.63940680263, 91247.17505649982, 91486.0, 92071.53964230136, 92241.0, 11434.028107610946, 11531.0, 11655.41722913834, 11830.40847957616, 11858.051355891681, 12258.877411225774, 12379.566715164927, 12443.128980971245, 12486.188397754117, 12865.356732163542, 11729.706757331134, 11961.547882684203, 11979.101567382308, 12320.753584928072, 12358.196717213352, 11371.886281137082, 11422.428878556206, 11703.180777345504, 11932.343721095423, 12323.198992065487, 11527.481263343338, 11574.0, 11575.652730418102, 11642.359670218219, 11923.0, 9422.811543769223, 9794.412335259907, 10000.949995249977, 10075.949620251851, 10504.894951050392, 10443.268971172249, 10802.351858888493, 11370.488328025423, 11487.885121148682, 11560.826587601025], "value": 7463.964718742562, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1572.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 117.0, 116.0, 117.0, 118.0, 118.0, 137.0, 173.0, 173.0, 118.0], "value": 129.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 116.0, 112.0, 153.0, 115.0, 115.0, 116.0, 119.0, 145.0, 116.0], "value": 125.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 212.0, 214.0, 207.0, 200.0, 197.0, 201.0, 199.0, 207.0, 194.0], "value": 203.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 58.0, 60.0, 84.0, 48.0, 59.0, 63.0, 86.0, 105.0, 81.0], "value": 72.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 70.0, 85.0, 74.0, 69.0, 70.0, 88.0, 70.0, 71.0, 114.0], "value": 80.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 87.0, 90.0, 122.0, 90.0, 87.0, 94.0, 100.0, 98.0, 107.0], "value": 98.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 107.0, 159.0, 118.0, 101.0, 97.0, 137.0, 101.0, 136.0, 150.0], "value": 123.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 116.0, 90.0, 90.0, 91.0, 89.0, 90.0, 89.0, 92.0, 90.0], "value": 97.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 54.0, 59.0, 58.0, 58.0, 58.0, 56.0, 55.0, 55.0], "value": 56.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 76.0, 86.0, 112.0, 73.0, 58.0, 97.0, 101.0, 64.0, 64.0], "value": 80.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 82.0, 83.0, 102.0, 85.0, 88.0, 90.0, 88.0, 96.0, 110.0], "value": 92.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 146.0, 140.0, 149.0, 155.0, 145.0, 167.0, 157.0, 185.0, 147.0], "value": 155.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 172.0, 172.0, 174.0, 174.0, 186.0, 230.0, 200.0, 174.0, 177.0], "value": 183.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 69.0, 69.0, 72.0, 82.0, 87.0, 84.0, 88.0, 74.0, 71.0], "value": 76.7, "unit": "score"}]}]} 06:44:29 INFO - Return code: 0 06:44:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:44:29 ERROR - # TBPL SUCCESS # 06:44:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:44:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:44:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:44:29 INFO - 2016-10-12 06:44:29.593 screenresolution[1673:11113] starting screenresolution argv=screenresolution get 06:44:29 INFO - 2016-10-12 06:44:29.596 screenresolution[1673:11113] Display 0: 1600x1200x32@60 06:44:29 INFO - 2016-10-12 06:44:29.602 screenresolution[1674:11116] starting screenresolution argv=screenresolution list 06:44:29 INFO - Available Modes on Display 0 06:44:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:44:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:44:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:44:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:44:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:44:29 INFO - Intel Iris: 06:44:29 INFO - Chipset Model: Intel Iris 06:44:29 INFO - Type: GPU 06:44:29 INFO - Bus: Built-In 06:44:29 INFO - VRAM (Dynamic, Max): 1536 MB 06:44:29 INFO - Vendor: Intel (0x8086) 06:44:29 INFO - Device ID: 0x0a2e 06:44:29 INFO - Revision ID: 0x0009 06:44:29 INFO - Displays: 06:44:29 INFO - Display: 06:44:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:44:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:44:29 INFO - Display Serial Number: 1600x1200 60 06:44:29 INFO - Main Display: Yes 06:44:29 INFO - Mirror: Off 06:44:29 INFO - Online: Yes 06:44:29 INFO - Rotation: Supported 06:44:29 INFO - Return code: 0 06:44:29 INFO - Running post-action listener: _resource_record_post_action 06:44:29 INFO - [mozharness: 2016-10-12 13:44:29.835962Z] Finished run-tests step (success) 06:44:29 INFO - Running post-run listener: _resource_record_post_run 06:44:29 INFO - Total resource usage - Wall time: 1212s; CPU: 54.0%; Read bytes: 40485888; Write bytes: 713469952; Read time: 383; Write time: 2044 06:44:29 INFO - TinderboxPrint: CPU usage
54.5% 06:44:29 INFO - TinderboxPrint: I/O read bytes / time
40,485,888 / 383 06:44:29 INFO - TinderboxPrint: I/O write bytes / time
713,469,952 / 2,044 06:44:29 INFO - TinderboxPrint: CPU idle
2,207.0 (45.5%) 06:44:29 INFO - TinderboxPrint: CPU system
983.4 (20.3%) 06:44:29 INFO - TinderboxPrint: CPU user
1,659.2 (34.2%) 06:44:29 INFO - TinderboxPrint: Swap in / out
451,543,040 / 0 06:44:29 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 408216064; Write bytes: 410695680; Read time: 30806; Write time: 846 06:44:29 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 36430848; Write bytes: 301574144; Read time: 350; Write time: 1194 06:44:30 INFO - Running post-run listener: _upload_blobber_files 06:44:30 INFO - Blob upload gear active. 06:44:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:44:30 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:44:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:44:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:44:30 INFO - (blobuploader) - INFO - Open directory for files ... 06:44:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:44:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:44:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:44:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:44:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:44:31 INFO - (blobuploader) - INFO - Done attempting. 06:44:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:44:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:44:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:44:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:44:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:44:32 INFO - (blobuploader) - INFO - Done attempting. 06:44:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:44:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:44:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:44:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:44:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:44:34 INFO - (blobuploader) - INFO - Done attempting. 06:44:34 INFO - (blobuploader) - INFO - Iteration through files over. 06:44:34 INFO - Return code: 0 06:44:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:44:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:44:34 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8b784beea77a472c4762efb140b8039f1873e0518df86cfffafe4f1325bedf5a3b336376dc856fd0244f34135802b85203ad8daaad1649500a6d0903bd4134e7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d081fbdcfb38d91fd4fdbefb8d3dcb84999c0c67d74d244127cf1a78f31ec8effb869c224ff178c75551afe273d703ad53b2c46ca434d7571ec157cf2316664a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e18cfc42588be7db081dc83c67550ea1bfc9461bfb15c9ffd83f5e95d359a6931cadabea5b2a1e9608b92afe352c73ec494caab2fc4bb7e762d763131bf362c7"} 06:44:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:44:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:44:34 INFO - Contents: 06:44:34 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8b784beea77a472c4762efb140b8039f1873e0518df86cfffafe4f1325bedf5a3b336376dc856fd0244f34135802b85203ad8daaad1649500a6d0903bd4134e7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d081fbdcfb38d91fd4fdbefb8d3dcb84999c0c67d74d244127cf1a78f31ec8effb869c224ff178c75551afe273d703ad53b2c46ca434d7571ec157cf2316664a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e18cfc42588be7db081dc83c67550ea1bfc9461bfb15c9ffd83f5e95d359a6931cadabea5b2a1e9608b92afe352c73ec494caab2fc4bb7e762d763131bf362c7"} 06:44:34 INFO - Running post-run listener: copy_logs_to_upload_dir 06:44:34 INFO - Copying logs to upload dir... 06:44:34 INFO - mkdir: /builds/slave/test/build/upload/logs 06:44:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.141912 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-10-12 06:44:35.040197) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-12 06:44:35.044225) ========= 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.3Y1PZSM4Ar/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.K9zhye8C5Z/Listeners TMPDIR=/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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/Fx-Team/sha512/8b784beea77a472c4762efb140b8039f1873e0518df86cfffafe4f1325bedf5a3b336376dc856fd0244f34135802b85203ad8daaad1649500a6d0903bd4134e7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d081fbdcfb38d91fd4fdbefb8d3dcb84999c0c67d74d244127cf1a78f31ec8effb869c224ff178c75551afe273d703ad53b2c46ca434d7571ec157cf2316664a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e18cfc42588be7db081dc83c67550ea1bfc9461bfb15c9ffd83f5e95d359a6931cadabea5b2a1e9608b92afe352c73ec494caab2fc4bb7e762d763131bf362c7"} build_url:https://queue.taskcluster.net/v1/task/duYfj-nyRXajoKc14IB9NA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010991 build_url: 'https://queue.taskcluster.net/v1/task/duYfj-nyRXajoKc14IB9NA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8b784beea77a472c4762efb140b8039f1873e0518df86cfffafe4f1325bedf5a3b336376dc856fd0244f34135802b85203ad8daaad1649500a6d0903bd4134e7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d081fbdcfb38d91fd4fdbefb8d3dcb84999c0c67d74d244127cf1a78f31ec8effb869c224ff178c75551afe273d703ad53b2c46ca434d7571ec157cf2316664a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e18cfc42588be7db081dc83c67550ea1bfc9461bfb15c9ffd83f5e95d359a6931cadabea5b2a1e9608b92afe352c73ec494caab2fc4bb7e762d763131bf362c7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-12 06:44:35.076747) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 06:44:35.077078) ========= 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.3Y1PZSM4Ar/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.K9zhye8C5Z/Listeners TMPDIR=/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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.004964 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 06:44:35.126735) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-12 06:44:35.127055) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-12 06:44:35.127371) ========= ========= Total master_lag: 0.67 =========