builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0209 starttime: 1490907938.22 results: success (0) buildid: 20170330120906 builduid: da2f53d64c714e02b0aebb4f3c6c3057 revision: 0a36cc120d6e7b8bc19176f5efac6b00dd9ad072 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-30 14:05:38.219341) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-30 14:05:38.219871) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-30 14:05:38.220150) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-30 14:05:38.245136) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 14:05:38.245475) ========= 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.KoyyRUu6cI/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.iCaWgT6dWO/Listeners TMPDIR=/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-03-30 14:05:38-- 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% 7.88M=0.001s 2017-03-30 14:05:38 (7.88 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.127288 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 14:05:38.395859) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 14:05:38.396170) ========= 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.KoyyRUu6cI/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.iCaWgT6dWO/Listeners TMPDIR=/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/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.023257 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 14:05:38.444898) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-30 14:05:38.445240) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 0a36cc120d6e7b8bc19176f5efac6b00dd9ad072 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 0a36cc120d6e7b8bc19176f5efac6b00dd9ad072 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.KoyyRUu6cI/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.iCaWgT6dWO/Listeners TMPDIR=/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-03-30 14:05:38,539 truncating revision to first 12 chars 2017-03-30 14:05:38,539 Setting DEBUG logging. 2017-03-30 14:05:38,539 attempt 1/10 2017-03-30 14:05:38,539 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/0a36cc120d6e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-30 14:05:39,340 unpacking tar archive at: mozilla-beta-0a36cc120d6e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.056247 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-30 14:05:39.527415) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-30 14:05:39.528156) ========= script_repo_revision: 0a36cc120d6e7b8bc19176f5efac6b00dd9ad072 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-30 14:05:39.528954) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-30 14:05:39.529668) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-30 14:05:39.550195) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-03-30 14:05:39.550492) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.KoyyRUu6cI/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.iCaWgT6dWO/Listeners TMPDIR=/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 14:05:39 INFO - MultiFileLogger online at 20170330 14:05:39 in /builds/slave/test 14:05:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 14:05:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:05:39 INFO - {'append_to_log': False, 14:05:39 INFO - 'base_work_dir': '/builds/slave/test', 14:05:39 INFO - 'blob_upload_branch': 'Mozilla-Beta', 14:05:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:05:39 INFO - 'branch': 'Mozilla-Beta', 14:05:39 INFO - 'buildbot_json_path': 'buildprops.json', 14:05:39 INFO - 'config_files': ('talos/mac_config.py',), 14:05:39 INFO - 'default_actions': ('clobber', 14:05:39 INFO - 'read-buildbot-config', 14:05:39 INFO - 'download-and-extract', 14:05:39 INFO - 'populate-webroot', 14:05:39 INFO - 'create-virtualenv', 14:05:39 INFO - 'install', 14:05:39 INFO - 'run-tests'), 14:05:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:05:39 INFO - 'download_minidump_stackwalk': True, 14:05:39 INFO - 'download_symbols': 'ondemand', 14:05:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:05:39 INFO - 'tooltool.py': '/tools/tooltool.py', 14:05:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:05:39 INFO - '/tools/misc-python/virtualenv.py')}, 14:05:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:05:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:05:39 INFO - 'installer_path': 'installer.exe', 14:05:39 INFO - 'log_level': 'info', 14:05:39 INFO - 'log_name': 'talos', 14:05:39 INFO - 'log_to_console': True, 14:05:39 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:05:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:05:39 INFO - 'opt_config_files': (), 14:05:39 INFO - 'pip_index': False, 14:05:39 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:05:39 INFO - 'cmd': ('bash', 14:05:39 INFO - '-c', 14:05:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:05:39 INFO - 'enabled': True, 14:05:39 INFO - 'halt_on_failure': False, 14:05:39 INFO - 'name': 'check_screen_resolution'},), 14:05:39 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:05:39 INFO - 'cmd': ('bash', 14:05:39 INFO - '-c', 14:05:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:05:39 INFO - 'enabled': True, 14:05:39 INFO - 'halt_on_failure': False, 14:05:39 INFO - 'name': 'check_screen_resolution'},), 14:05:39 INFO - 'run_cmd_checks_enabled': True, 14:05:39 INFO - 'sps_profile': False, 14:05:39 INFO - 'sps_profile_interval': 0, 14:05:39 INFO - 'suite': 'dromaeojs-e10s', 14:05:39 INFO - 'system_bits': '32', 14:05:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:05:39 INFO - 'title': 't-yosemite-r7-0209', 14:05:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:05:39 INFO - 'use_talos_json': True, 14:05:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:05:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:05:39 INFO - 'work_dir': 'build'} 14:05:39 INFO - [mozharness: 2017-03-30 21:05:39.755538Z] Running clobber step. 14:05:39 INFO - Running pre-action listener: _resource_record_pre_action 14:05:39 INFO - Running main action method: clobber 14:05:39 INFO - rmtree: /builds/slave/test/build 14:05:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:05:41 INFO - Running post-action listener: _resource_record_post_action 14:05:41 INFO - [mozharness: 2017-03-30 21:05:41.953380Z] Finished clobber step (success) 14:05:41 INFO - [mozharness: 2017-03-30 21:05:41.953588Z] Running read-buildbot-config step. 14:05:41 INFO - Running pre-action listener: _resource_record_pre_action 14:05:41 INFO - Running main action method: read_buildbot_config 14:05:41 INFO - Using buildbot properties: 14:05:41 INFO - { 14:05:41 INFO - "project": "", 14:05:41 INFO - "product": "firefox", 14:05:41 INFO - "script_repo_revision": "production", 14:05:41 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 14:05:41 INFO - "repository": "", 14:05:41 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 14:05:41 INFO - "buildid": "20170330120906", 14:05:41 INFO - "pgo_build": "False", 14:05:41 INFO - "basedir": "/builds/slave/test", 14:05:41 INFO - "buildnumber": 16, 14:05:41 INFO - "slavename": "t-yosemite-r7-0209", 14:05:41 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 14:05:41 INFO - "platform": "yosemite_r7", 14:05:41 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 14:05:41 INFO - "branch": "mozilla-beta", 14:05:41 INFO - "repo_path": "releases/mozilla-beta", 14:05:41 INFO - "revision": "0a36cc120d6e7b8bc19176f5efac6b00dd9ad072", 14:05:41 INFO - "stage_platform": "macosx64", 14:05:41 INFO - "builduid": "da2f53d64c714e02b0aebb4f3c6c3057", 14:05:41 INFO - "slavebuilddir": "test" 14:05:41 INFO - } 14:05:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/MGXW8r5bSNu7I7p_gcE95g/artifacts/public/build/firefox-53.0.en-US.mac.dmg. 14:05:41 INFO - Running post-action listener: _resource_record_post_action 14:05:41 INFO - [mozharness: 2017-03-30 21:05:41.957387Z] Finished read-buildbot-config step (success) 14:05:41 INFO - [mozharness: 2017-03-30 21:05:41.957497Z] Running download-and-extract step. 14:05:41 INFO - Running pre-action listener: _resource_record_pre_action 14:05:41 INFO - Running main action method: download_and_extract 14:05:41 INFO - mkdir: /builds/slave/test/build/tests 14:05:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:05:41 INFO - trying https://queue.taskcluster.net/v1/task/MGXW8r5bSNu7I7p_gcE95g/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json 14:05:41 INFO - Downloading https://queue.taskcluster.net/v1/task/MGXW8r5bSNu7I7p_gcE95g/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 14:05:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MGXW8r5bSNu7I7p_gcE95g/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json'}, attempt #1 14:05:43 INFO - Downloaded 1165 bytes. 14:05:43 INFO - Reading from file /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 14:05:43 INFO - Using the following test package requirements: 14:05:43 INFO - {u'common': [u'firefox-53.0.en-US.mac.common.tests.zip'], 14:05:43 INFO - u'cppunittest': [u'firefox-53.0.en-US.mac.common.tests.zip', 14:05:43 INFO - u'firefox-53.0.en-US.mac.cppunittest.tests.zip'], 14:05:43 INFO - u'gtest': [u'firefox-53.0.en-US.mac.common.tests.zip', 14:05:43 INFO - u'firefox-53.0.en-US.mac.gtest.tests.zip'], 14:05:43 INFO - u'jittest': [u'firefox-53.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 14:05:43 INFO - u'mochitest': [u'firefox-53.0.en-US.mac.common.tests.zip', 14:05:43 INFO - u'firefox-53.0.en-US.mac.mochitest.tests.zip'], 14:05:43 INFO - u'mozbase': [u'firefox-53.0.en-US.mac.common.tests.zip'], 14:05:43 INFO - u'reftest': [u'firefox-53.0.en-US.mac.common.tests.zip', 14:05:43 INFO - u'firefox-53.0.en-US.mac.reftest.tests.zip'], 14:05:43 INFO - u'talos': [u'firefox-53.0.en-US.mac.common.tests.zip', 14:05:43 INFO - u'firefox-53.0.en-US.mac.talos.tests.zip'], 14:05:43 INFO - u'web-platform': [u'firefox-53.0.en-US.mac.common.tests.zip', 14:05:43 INFO - u'firefox-53.0.en-US.mac.web-platform.tests.zip'], 14:05:43 INFO - u'xpcshell': [u'firefox-53.0.en-US.mac.common.tests.zip', 14:05:43 INFO - u'firefox-53.0.en-US.mac.xpcshell.tests.zip']} 14:05:43 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip'] for test suite category: common 14:05:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MGXW8r5bSNu7I7p_gcE95g/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 14:05:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MGXW8r5bSNu7I7p_gcE95g/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 14:05:43 INFO - Fetch https://queue.taskcluster.net/v1/task/MGXW8r5bSNu7I7p_gcE95g/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 14:05:44 INFO - Expected file size: 16108833 14:05:44 INFO - Obtained file size: 16108833 14:05:50 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip', u'firefox-53.0.en-US.mac.talos.tests.zip'] for test suite category: talos 14:05:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MGXW8r5bSNu7I7p_gcE95g/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 14:05:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MGXW8r5bSNu7I7p_gcE95g/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 14:05:50 INFO - Fetch https://queue.taskcluster.net/v1/task/MGXW8r5bSNu7I7p_gcE95g/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 14:05:51 INFO - Expected file size: 16108833 14:05:51 INFO - Obtained file size: 16108833 14:05:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MGXW8r5bSNu7I7p_gcE95g/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip 14:05:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MGXW8r5bSNu7I7p_gcE95g/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip'}, attempt #1 14:05:58 INFO - Fetch https://queue.taskcluster.net/v1/task/MGXW8r5bSNu7I7p_gcE95g/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip into memory 14:05:59 INFO - Expected file size: 14403663 14:05:59 INFO - Obtained file size: 14403663 14:05:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:05:59 INFO - trying https://queue.taskcluster.net/v1/task/MGXW8r5bSNu7I7p_gcE95g/artifacts/public/build/firefox-53.0.en-US.mac.dmg 14:05:59 INFO - Downloading https://queue.taskcluster.net/v1/task/MGXW8r5bSNu7I7p_gcE95g/artifacts/public/build/firefox-53.0.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0.en-US.mac.dmg 14:05:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MGXW8r5bSNu7I7p_gcE95g/artifacts/public/build/firefox-53.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg'}, attempt #1 14:06:01 INFO - Downloaded 58692004 bytes. 14:06:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MGXW8r5bSNu7I7p_gcE95g/artifacts/public/build/firefox-53.0.en-US.mac.dmg 14:06:01 INFO - mkdir: /builds/slave/test/properties 14:06:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:06:01 INFO - Writing to file /builds/slave/test/properties/build_url 14:06:01 INFO - Contents: 14:06:01 INFO - build_url:https://queue.taskcluster.net/v1/task/MGXW8r5bSNu7I7p_gcE95g/artifacts/public/build/firefox-53.0.en-US.mac.dmg 14:06:02 INFO - Running post-action listener: _resource_record_post_action 14:06:02 INFO - Running post-action listener: set_extra_try_arguments 14:06:02 INFO - [mozharness: 2017-03-30 21:06:02.320898Z] Finished download-and-extract step (success) 14:06:02 INFO - [mozharness: 2017-03-30 21:06:02.321046Z] Running populate-webroot step. 14:06:02 INFO - Running pre-action listener: _resource_record_pre_action 14:06:02 INFO - Running main action method: populate_webroot 14:06:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:06:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:06:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:06:02 INFO - '--tppagecycles', 14:06:02 INFO - '7'], 14:06:02 INFO - 'tests': ['tsvgm']}}, 14:06:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:06:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:06:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:06:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:06:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:06:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:06:02 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 14:06:02 INFO - 'talos_options': ['--disable-e10s'], 14:06:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:06:02 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:06:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:06:02 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 14:06:02 INFO - 'talos_options': ['--disable-e10s'], 14:06:02 INFO - 'tests': ['damp', 'tps']}, 14:06:02 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:06:02 INFO - 'tests': ['damp', 'tps']}, 14:06:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:06:02 INFO - 'tests': ['dromaeo_dom']}, 14:06:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:06:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:06:02 INFO - 'tests': ['basic_compositor_video']}, 14:06:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:06:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:06:02 INFO - 'tests': ['a11yr', 14:06:02 INFO - 'ts_paint', 14:06:02 INFO - 'tpaint', 14:06:02 INFO - 'sessionrestore', 14:06:02 INFO - 'sessionrestore_no_auto_restore', 14:06:02 INFO - 'tabpaint']}, 14:06:02 INFO - 'other-e10s': {'tests': ['a11yr', 14:06:02 INFO - 'ts_paint', 14:06:02 INFO - 'tpaint', 14:06:02 INFO - 'sessionrestore', 14:06:02 INFO - 'sessionrestore_no_auto_restore', 14:06:02 INFO - 'tabpaint']}, 14:06:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:06:02 INFO - 'ts_paint', 14:06:02 INFO - 'tpaint', 14:06:02 INFO - 'sessionrestore', 14:06:02 INFO - 'sessionrestore_no_auto_restore', 14:06:02 INFO - 'tabpaint']}, 14:06:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:06:02 INFO - 'ts_paint', 14:06:02 INFO - 'tpaint', 14:06:02 INFO - 'sessionrestore', 14:06:02 INFO - 'sessionrestore_no_auto_restore', 14:06:02 INFO - 'tabpaint']}, 14:06:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:06:02 INFO - 'tests': ['a11yr', 14:06:02 INFO - 'ts_paint', 14:06:02 INFO - 'tpaint', 14:06:02 INFO - 'sessionrestore', 14:06:02 INFO - 'sessionrestore_no_auto_restore', 14:06:02 INFO - 'tabpaint']}, 14:06:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:06:02 INFO - 'tests': ['a11yr', 14:06:02 INFO - 'ts_paint', 14:06:02 INFO - 'tpaint', 14:06:02 INFO - 'sessionrestore', 14:06:02 INFO - 'sessionrestore_no_auto_restore', 14:06:02 INFO - 'tabpaint']}, 14:06:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:06:02 INFO - 'tests': ['tsvgx', 14:06:02 INFO - 'tsvgr_opacity', 14:06:02 INFO - 'tart', 14:06:02 INFO - 'tscrollx', 14:06:02 INFO - 'cart', 14:06:02 INFO - 'tsvg_static']}, 14:06:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:06:02 INFO - 'tsvgr_opacity', 14:06:02 INFO - 'tart', 14:06:02 INFO - 'tscrollx', 14:06:02 INFO - 'cart', 14:06:02 INFO - 'tsvg_static']}, 14:06:02 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 14:06:02 INFO - 'talos_options': ['--disable-e10s'], 14:06:02 INFO - 'tests': ['tp5o']}, 14:06:02 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:06:02 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 14:06:02 INFO - 'talos_options': ['--disable-e10s', 14:06:02 INFO - '--xperf_path', 14:06:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:06:02 INFO - 'tests': ['tp5n']}, 14:06:02 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:06:02 INFO - 'talos_options': ['--xperf_path', 14:06:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:06:02 INFO - 'tests': ['tp5n']}}, 14:06:02 INFO - 'talos.zip': {'path': '', 14:06:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:06:02 INFO - Running post-action listener: _resource_record_post_action 14:06:02 INFO - [mozharness: 2017-03-30 21:06:02.339684Z] Finished populate-webroot step (success) 14:06:02 INFO - [mozharness: 2017-03-30 21:06:02.339819Z] Running create-virtualenv step. 14:06:02 INFO - Running pre-action listener: _resource_record_pre_action 14:06:02 INFO - Running main action method: create_virtualenv 14:06:02 INFO - Creating virtualenv /builds/slave/test/build/venv 14:06:02 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:06:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:06:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:06:02 INFO - Using real prefix '/tools/python27' 14:06:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:06:03 INFO - Installing distribute.............................................................................................................................................................................................done. 14:06:06 INFO - Installing pip.................done. 14:06:06 INFO - Return code: 0 14:06:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:06:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:06:06 INFO - Reading from file tmpfile_stdout 14:06:06 INFO - Output received: 14:06:06 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 14:06:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:06:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:06:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:06:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:06 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 0x10082cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10082f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9815a2800>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10060ad30>, '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 0x100531db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1005ffbe8>, '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.KoyyRUu6cI/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.iCaWgT6dWO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:06:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:06:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:06:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KoyyRUu6cI/Render', 14:06:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:06:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:06:06 INFO - 'HOME': '/Users/cltbld', 14:06:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:06:06 INFO - 'LOGNAME': 'cltbld', 14:06:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:06:06 INFO - 'MOZ_NO_REMOTE': '1', 14:06:06 INFO - 'NO_EM_RESTART': '1', 14:06:06 INFO - 'PAGER': '/bin/cat', 14:06:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:06:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:06:06 INFO - 'PWD': '/builds/slave/test', 14:06:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:06:06 INFO - 'SHELL': '/bin/bash', 14:06:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iCaWgT6dWO/Listeners', 14:06:06 INFO - 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', 14:06:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:06:06 INFO - 'USER': 'cltbld', 14:06:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:06:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:06:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:06:06 INFO - 'XPC_FLAGS': '0x0', 14:06:06 INFO - 'XPC_SERVICE_NAME': '0', 14:06:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:06:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:06:06 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:06:06 INFO - Cleaning up... 14:06:06 INFO - Return code: 0 14:06:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:06:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:06:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:06:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:06 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 0x10082cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10082f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9815a2800>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10060ad30>, '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 0x100531db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1005ffbe8>, '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.KoyyRUu6cI/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.iCaWgT6dWO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:06:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:06:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:06:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KoyyRUu6cI/Render', 14:06:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:06:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:06:06 INFO - 'HOME': '/Users/cltbld', 14:06:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:06:06 INFO - 'LOGNAME': 'cltbld', 14:06:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:06:06 INFO - 'MOZ_NO_REMOTE': '1', 14:06:06 INFO - 'NO_EM_RESTART': '1', 14:06:06 INFO - 'PAGER': '/bin/cat', 14:06:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:06:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:06:06 INFO - 'PWD': '/builds/slave/test', 14:06:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:06:06 INFO - 'SHELL': '/bin/bash', 14:06:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iCaWgT6dWO/Listeners', 14:06:06 INFO - 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', 14:06:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:06:06 INFO - 'USER': 'cltbld', 14:06:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:06:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:06:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:06:06 INFO - 'XPC_FLAGS': '0x0', 14:06:06 INFO - 'XPC_SERVICE_NAME': '0', 14:06:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:06:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:06:06 INFO - Downloading/unpacking psutil>=3.1.1 14:06:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:06:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:06:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:06:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:06:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:06:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:06:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:06:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:06:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:06:10 INFO - Installing collected packages: psutil 14:06:10 INFO - Running setup.py install for psutil 14:06:10 INFO - building 'psutil._psutil_osx' extension 14:06:10 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 14:06:10 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 14:06:10 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 14:06:10 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 14:06:10 INFO - building 'psutil._psutil_posix' extension 14:06:10 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 14:06:11 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:06:11 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:06:11 INFO - ^ 14:06:11 INFO - 1 warning generated. 14:06:11 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 14:06:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:06:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:06:11 INFO - Successfully installed psutil 14:06:11 INFO - Cleaning up... 14:06:11 INFO - Return code: 0 14:06:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:06:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:06:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:06:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:11 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 0x10082cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10082f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9815a2800>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10060ad30>, '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 0x100531db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1005ffbe8>, '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.KoyyRUu6cI/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.iCaWgT6dWO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:06:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:06:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:06:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KoyyRUu6cI/Render', 14:06:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:06:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:06:11 INFO - 'HOME': '/Users/cltbld', 14:06:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:06:11 INFO - 'LOGNAME': 'cltbld', 14:06:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:06:11 INFO - 'MOZ_NO_REMOTE': '1', 14:06:11 INFO - 'NO_EM_RESTART': '1', 14:06:11 INFO - 'PAGER': '/bin/cat', 14:06:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:06:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:06:11 INFO - 'PWD': '/builds/slave/test', 14:06:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:06:11 INFO - 'SHELL': '/bin/bash', 14:06:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iCaWgT6dWO/Listeners', 14:06:11 INFO - 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', 14:06:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:06:11 INFO - 'USER': 'cltbld', 14:06:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:06:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:06:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:06:11 INFO - 'XPC_FLAGS': '0x0', 14:06:11 INFO - 'XPC_SERVICE_NAME': '0', 14:06:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:06:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:06:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:06: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 14:06: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 14:06: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 14:06: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 14:06: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 14:06: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 14:06:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:06:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:06:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:06:14 INFO - Installing collected packages: mozsystemmonitor 14:06:14 INFO - Running setup.py install for mozsystemmonitor 14:06:14 INFO - Successfully installed mozsystemmonitor 14:06:14 INFO - Cleaning up... 14:06:14 INFO - Return code: 0 14:06:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:06:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:06:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:06:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10082cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10082f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9815a2800>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10060ad30>, '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 0x100531db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1005ffbe8>, '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.KoyyRUu6cI/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.iCaWgT6dWO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:06:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:06:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:06:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KoyyRUu6cI/Render', 14:06:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:06:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:06:14 INFO - 'HOME': '/Users/cltbld', 14:06:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:06:14 INFO - 'LOGNAME': 'cltbld', 14:06:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:06:14 INFO - 'MOZ_NO_REMOTE': '1', 14:06:14 INFO - 'NO_EM_RESTART': '1', 14:06:14 INFO - 'PAGER': '/bin/cat', 14:06:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:06:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:06:14 INFO - 'PWD': '/builds/slave/test', 14:06:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:06:14 INFO - 'SHELL': '/bin/bash', 14:06:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iCaWgT6dWO/Listeners', 14:06:14 INFO - 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', 14:06:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:06:14 INFO - 'USER': 'cltbld', 14:06:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:06:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:06:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:06:14 INFO - 'XPC_FLAGS': '0x0', 14:06:14 INFO - 'XPC_SERVICE_NAME': '0', 14:06:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:06:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:06:14 INFO - Downloading/unpacking jsonschema==2.5.1 14:06:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:06:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:06:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:06:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:06:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:06:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:06:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:06:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:06:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:06:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:06:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:06:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:06:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:06:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:06:17 INFO - Downloading functools32-3.2.3-2.tar.gz 14:06:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:06:17 INFO - warning: no files found matching '*.txt' 14:06:17 INFO - no previously-included directories found matching 'build' 14:06:17 INFO - no previously-included directories found matching 'dist' 14:06:17 INFO - no previously-included directories found matching '.git*' 14:06:17 INFO - Installing collected packages: jsonschema, functools32 14:06:17 INFO - Running setup.py install for functools32 14:06:17 INFO - warning: no files found matching '*.txt' 14:06:17 INFO - no previously-included directories found matching 'build' 14:06:17 INFO - no previously-included directories found matching 'dist' 14:06:17 INFO - no previously-included directories found matching '.git*' 14:06:17 INFO - Successfully installed jsonschema functools32 14:06:17 INFO - Cleaning up... 14:06:18 INFO - Return code: 0 14:06:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:06:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:06:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:06:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:18 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 0x10082cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10082f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9815a2800>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10060ad30>, '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 0x100531db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1005ffbe8>, '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.KoyyRUu6cI/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.iCaWgT6dWO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:06:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:06:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 14:06:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KoyyRUu6cI/Render', 14:06:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:06:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:06:18 INFO - 'HOME': '/Users/cltbld', 14:06:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:06:18 INFO - 'LOGNAME': 'cltbld', 14:06:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:06:18 INFO - 'MOZ_NO_REMOTE': '1', 14:06:18 INFO - 'NO_EM_RESTART': '1', 14:06:18 INFO - 'PAGER': '/bin/cat', 14:06:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:06:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:06:18 INFO - 'PWD': '/builds/slave/test', 14:06:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:06:18 INFO - 'SHELL': '/bin/bash', 14:06:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iCaWgT6dWO/Listeners', 14:06:18 INFO - 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', 14:06:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:06:18 INFO - 'USER': 'cltbld', 14:06:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:06:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:06:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:06:18 INFO - 'XPC_FLAGS': '0x0', 14:06:18 INFO - 'XPC_SERVICE_NAME': '0', 14:06:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:06:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:06:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:06:18 INFO - Cleaning up... 14:06:18 INFO - Return code: 0 14:06:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:06:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:06:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:06:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:18 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 0x10082cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10082f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9815a2800>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10060ad30>, '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 0x100531db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1005ffbe8>, '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.KoyyRUu6cI/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.iCaWgT6dWO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:06:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:06:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:06:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KoyyRUu6cI/Render', 14:06:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:06:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:06:18 INFO - 'HOME': '/Users/cltbld', 14:06:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:06:18 INFO - 'LOGNAME': 'cltbld', 14:06:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:06:18 INFO - 'MOZ_NO_REMOTE': '1', 14:06:18 INFO - 'NO_EM_RESTART': '1', 14:06:18 INFO - 'PAGER': '/bin/cat', 14:06:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:06:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:06:18 INFO - 'PWD': '/builds/slave/test', 14:06:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:06:18 INFO - 'SHELL': '/bin/bash', 14:06:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iCaWgT6dWO/Listeners', 14:06:18 INFO - 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', 14:06:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:06:18 INFO - 'USER': 'cltbld', 14:06:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:06:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:06:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:06:18 INFO - 'XPC_FLAGS': '0x0', 14:06:18 INFO - 'XPC_SERVICE_NAME': '0', 14:06:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:06:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:06:18 INFO - Downloading/unpacking blobuploader==1.2.4 14:06:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:06:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:06:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:06:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:06:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:06:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:06:21 INFO - Downloading blobuploader-1.2.4.tar.gz 14:06:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:06:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:06:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:06:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:06:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:06:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:06:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:06:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:06:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:06:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:06:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:06:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:06:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:06:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:06:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:06:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:06:22 INFO - Downloading docopt-0.6.1.tar.gz 14:06:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:06:22 INFO - Installing collected packages: blobuploader, requests, docopt 14:06:22 INFO - Running setup.py install for blobuploader 14:06:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:06:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:06:22 INFO - Running setup.py install for requests 14:06:23 INFO - Running setup.py install for docopt 14:06:23 INFO - Successfully installed blobuploader requests docopt 14:06:23 INFO - Cleaning up... 14:06:23 INFO - Return code: 0 14:06:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:06: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')]} 14:06:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:06:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06: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')]} 14:06:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:06:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:23 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 0x10082cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10082f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9815a2800>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10060ad30>, '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 0x100531db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1005ffbe8>, '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.KoyyRUu6cI/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.iCaWgT6dWO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:06:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:06:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:06:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KoyyRUu6cI/Render', 14:06:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:06:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:06:23 INFO - 'HOME': '/Users/cltbld', 14:06:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:06:23 INFO - 'LOGNAME': 'cltbld', 14:06:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:06:23 INFO - 'MOZ_NO_REMOTE': '1', 14:06:23 INFO - 'NO_EM_RESTART': '1', 14:06:23 INFO - 'PAGER': '/bin/cat', 14:06:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:06:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:06:23 INFO - 'PWD': '/builds/slave/test', 14:06:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:06:23 INFO - 'SHELL': '/bin/bash', 14:06:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iCaWgT6dWO/Listeners', 14:06:23 INFO - 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', 14:06:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:06:23 INFO - 'USER': 'cltbld', 14:06:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:06:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:06:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:06:23 INFO - 'XPC_FLAGS': '0x0', 14:06:23 INFO - 'XPC_SERVICE_NAME': '0', 14:06:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:06:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:06:23 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-BBneta-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:06:23 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-iLn2FX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:06:23 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-iEd3Yp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:06:23 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-ZRytm3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:06:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:06:24 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-vADoIQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:06:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:06:24 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-cwY9Tz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:06:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:06:24 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-CGQrvq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:06:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:06:24 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-X_HE7j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:06:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:06:24 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-aNoXtL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:06:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:06:24 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-BUA1h5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:06:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:06:24 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-a0goYQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:06:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:06:24 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-YuVmUB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:06:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:06:24 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-yulqaO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:06:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:06:24 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-HDPDBl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:06:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:06:25 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-yKgsOk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:06:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:06:25 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-hOujnZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:06:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:06:25 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-NpC3P1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:06:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:06:25 INFO - Running setup.py install for manifestparser 14:06:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:06:25 INFO - Running setup.py install for mozcrash 14:06:25 INFO - Running setup.py install for mozdebug 14:06:25 INFO - Running setup.py install for mozdevice 14:06:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:06:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:06:26 INFO - Running setup.py install for mozfile 14:06:26 INFO - Running setup.py install for mozhttpd 14:06:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:06:26 INFO - Running setup.py install for mozinfo 14:06:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:06:26 INFO - Running setup.py install for mozInstall 14:06:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:06:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:06:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:06:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:06:26 INFO - Running setup.py install for mozleak 14:06:26 INFO - Running setup.py install for mozlog 14:06:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:06:26 INFO - Running setup.py install for moznetwork 14:06:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:06:27 INFO - Running setup.py install for mozprocess 14:06:27 INFO - Running setup.py install for mozprofile 14:06:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:06:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:06:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:06:27 INFO - Running setup.py install for mozrunner 14:06:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:06:27 INFO - Running setup.py install for mozscreenshot 14:06:27 INFO - Running setup.py install for moztest 14:06:27 INFO - Running setup.py install for mozversion 14:06:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:06:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:06:27 INFO - Cleaning up... 14:06:28 INFO - Return code: 0 14:06:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:06:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:06:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:06:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:28 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 0x10082cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10082f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9815a2800>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10060ad30>, '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 0x100531db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1005ffbe8>, '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.KoyyRUu6cI/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.iCaWgT6dWO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:06:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:06:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:06:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KoyyRUu6cI/Render', 14:06:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:06:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:06:28 INFO - 'HOME': '/Users/cltbld', 14:06:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:06:28 INFO - 'LOGNAME': 'cltbld', 14:06:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:06:28 INFO - 'MOZ_NO_REMOTE': '1', 14:06:28 INFO - 'NO_EM_RESTART': '1', 14:06:28 INFO - 'PAGER': '/bin/cat', 14:06:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:06:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:06:28 INFO - 'PWD': '/builds/slave/test', 14:06:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:06:28 INFO - 'SHELL': '/bin/bash', 14:06:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iCaWgT6dWO/Listeners', 14:06:28 INFO - 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', 14:06:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:06:28 INFO - 'USER': 'cltbld', 14:06:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:06:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:06:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:06:28 INFO - 'XPC_FLAGS': '0x0', 14:06:28 INFO - 'XPC_SERVICE_NAME': '0', 14:06:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:06:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:06:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:06:28 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-2Dpe9U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:06:28 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:06:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:06:28 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-cH1I5D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:06:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:06:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:06:28 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-XXipqd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:06:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:06:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:06:28 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-BSS8ZD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:06:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:06:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:06:28 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-6XILTr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:06:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:06:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:06:28 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-U7bRpj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:06:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:06:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:06:28 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-FnYBTz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:06:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:06:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:06:29 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-PjL8Bp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:06:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:06:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:06:29 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-x3jX46-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:06:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 14:06:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:06:29 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-3L8jQt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:06:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:06:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:06:29 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-NPg3Dt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:06:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:06:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:06:29 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-fCLVqN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:06:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:06:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:06:29 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-G0xL7h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:06:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:06:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:06:29 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-6OugSH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:06:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:06:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:06:29 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-x7UMPf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:06:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:06:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:06:29 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-iYMdn6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:06:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:06:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:06:29 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-9e_Lbu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:06:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:06:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:06:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:06:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:06:30 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:06:30 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:06:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:06:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:06:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:06:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:06:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:06:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:06:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:06:32 INFO - Downloading blessings-1.6.tar.gz 14:06:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:06:32 INFO - Installing collected packages: blessings 14:06:32 INFO - Running setup.py install for blessings 14:06:32 INFO - Successfully installed blessings 14:06:32 INFO - Cleaning up... 14:06:33 INFO - Return code: 0 14:06:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:06:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:06:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:06:33 INFO - Reading from file tmpfile_stdout 14:06:33 INFO - Current package versions: 14:06:33 INFO - blessings == 1.6 14:06:33 INFO - blobuploader == 1.2.4 14:06:33 INFO - docopt == 0.6.1 14:06:33 INFO - functools32 == 3.2.3-2 14:06:33 INFO - jsonschema == 2.5.1 14:06:33 INFO - manifestparser == 1.1 14:06:33 INFO - mozInstall == 1.12 14:06:33 INFO - mozcrash == 1.0 14:06:33 INFO - mozdebug == 0.1 14:06:33 INFO - mozdevice == 0.49 14:06:33 INFO - mozfile == 1.2 14:06:33 INFO - mozhttpd == 0.7 14:06:33 INFO - mozinfo == 0.9 14:06:33 INFO - mozleak == 0.1 14:06:33 INFO - mozlog == 3.4 14:06:33 INFO - moznetwork == 0.27 14:06:33 INFO - mozprocess == 0.24 14:06:33 INFO - mozprofile == 0.28 14:06:33 INFO - mozrunner == 6.13 14:06:33 INFO - mozscreenshot == 0.1 14:06:33 INFO - mozsystemmonitor == 0.3 14:06:33 INFO - moztest == 0.8 14:06:33 INFO - mozversion == 1.4 14:06:33 INFO - psutil == 3.1.1 14:06:33 INFO - requests == 1.2.3 14:06:33 INFO - wsgiref == 0.1.2 14:06:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:06:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:06:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:06:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:34 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 0x10082cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10082f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9815a2800>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10060ad30>, '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 0x100531db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1005ffbe8>, '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.KoyyRUu6cI/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.iCaWgT6dWO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:06:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:06:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:06:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KoyyRUu6cI/Render', 14:06:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:06:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:06:34 INFO - 'HOME': '/Users/cltbld', 14:06:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:06:34 INFO - 'LOGNAME': 'cltbld', 14:06:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:06:34 INFO - 'MOZ_NO_REMOTE': '1', 14:06:34 INFO - 'NO_EM_RESTART': '1', 14:06:34 INFO - 'PAGER': '/bin/cat', 14:06:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:06:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:06:34 INFO - 'PWD': '/builds/slave/test', 14:06:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:06:34 INFO - 'SHELL': '/bin/bash', 14:06:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iCaWgT6dWO/Listeners', 14:06:34 INFO - 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', 14:06:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:06:34 INFO - 'USER': 'cltbld', 14:06:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:06:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:06:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:06:34 INFO - 'XPC_FLAGS': '0x0', 14:06:34 INFO - 'XPC_SERVICE_NAME': '0', 14:06:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:06:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:06:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:06:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 14:06:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:06:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:06:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 14:06:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 14:06:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 14:06:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 14:06:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 14:06:34 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:06:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:06:34 INFO - Cleaning up... 14:06:34 INFO - Return code: 0 14:06:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:06:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:06:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:06:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:35 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 0x10082cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10082f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9815a2800>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10060ad30>, '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 0x100531db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1005ffbe8>, '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.KoyyRUu6cI/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.iCaWgT6dWO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:06:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:06:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:06:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KoyyRUu6cI/Render', 14:06:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:06:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:06:35 INFO - 'HOME': '/Users/cltbld', 14:06:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:06:35 INFO - 'LOGNAME': 'cltbld', 14:06:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:06:35 INFO - 'MOZ_NO_REMOTE': '1', 14:06:35 INFO - 'NO_EM_RESTART': '1', 14:06:35 INFO - 'PAGER': '/bin/cat', 14:06:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:06:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:06:35 INFO - 'PWD': '/builds/slave/test', 14:06:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:06:35 INFO - 'SHELL': '/bin/bash', 14:06:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iCaWgT6dWO/Listeners', 14:06:35 INFO - 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', 14:06:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:06:35 INFO - 'USER': 'cltbld', 14:06:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:06:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:06:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:06:35 INFO - 'XPC_FLAGS': '0x0', 14:06:35 INFO - 'XPC_SERVICE_NAME': '0', 14:06:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:06:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:06:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:06:35 INFO - Cleaning up... 14:06:35 INFO - Return code: 0 14:06:35 INFO - Running post-action listener: _resource_record_post_action 14:06:35 INFO - Running post-action listener: _start_resource_monitoring 14:06:35 INFO - Starting resource monitoring. 14:06:35 INFO - [mozharness: 2017-03-30 21:06:35.509301Z] Finished create-virtualenv step (success) 14:06:35 INFO - [mozharness: 2017-03-30 21:06:35.510301Z] Running install step. 14:06:35 INFO - Running pre-action listener: _resource_record_pre_action 14:06:35 INFO - Running main action method: install 14:06:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:06:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:06:35 INFO - Reading from file tmpfile_stdout 14:06:35 INFO - Detecting whether we're running mozinstall >=1.0... 14:06:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:06:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:06:35 INFO - Reading from file tmpfile_stdout 14:06:35 INFO - Output received: 14:06:35 INFO - Usage: mozinstall [options] installer 14:06:35 INFO - Options: 14:06:35 INFO - -h, --help show this help message and exit 14:06:35 INFO - -d DEST, --destination=DEST 14:06:35 INFO - Directory to install application into. [default: 14:06:35 INFO - "/builds/slave/test"] 14:06:35 INFO - --app=APP Application being installed. [default: firefox] 14:06:35 INFO - mkdir: /builds/slave/test/build/application 14:06:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 14:06:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0.en-US.mac.dmg --destination /builds/slave/test/build/application 14:06:50 INFO - Reading from file tmpfile_stdout 14:06:50 INFO - Output received: 14:06:50 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 14:06:50 INFO - Running post-action listener: _resource_record_post_action 14:06:50 INFO - [mozharness: 2017-03-30 21:06:50.565739Z] Finished install step (success) 14:06:50 INFO - [mozharness: 2017-03-30 21:06:50.565885Z] Running run-tests step. 14:06:50 INFO - Running pre-action listener: _resource_record_pre_action 14:06:50 INFO - Running main action method: run_tests 14:06:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:06:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:06:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:06:50 INFO - 2017-03-30 14:06:50.580 screenresolution[2506:32595] starting screenresolution argv=screenresolution get 14:06:50 INFO - 2017-03-30 14:06:50.583 screenresolution[2506:32595] Display 0: 1600x1200x32@60 14:06:50 INFO - 2017-03-30 14:06:50.589 screenresolution[2507:32597] starting screenresolution argv=screenresolution list 14:06:50 INFO - Available Modes on Display 0 14:06:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:06:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:06:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:06:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:06:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:06:50 INFO - Intel Iris: 14:06:50 INFO - Chipset Model: Intel Iris 14:06:50 INFO - Type: GPU 14:06:50 INFO - Bus: Built-In 14:06:50 INFO - VRAM (Dynamic, Max): 1536 MB 14:06:50 INFO - Vendor: Intel (0x8086) 14:06:50 INFO - Device ID: 0x0a2e 14:06:50 INFO - Revision ID: 0x0009 14:06:50 INFO - Displays: 14:06:50 INFO - Display: 14:06:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:06:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:06:50 INFO - Display Serial Number: 1600x1200 60 14:06:50 INFO - Main Display: Yes 14:06:50 INFO - Mirror: Off 14:06:50 INFO - Online: Yes 14:06:50 INFO - Rotation: Supported 14:06:50 INFO - Return code: 0 14:06:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:06:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:06:50 INFO - Python 2.7.3 14:06:50 INFO - Return code: 0 14:06:50 INFO - grabbing minidump binary from tooltool 14:06:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:50 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 0x10060ad30>, '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 0x100531db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1005ffbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:06:50 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:06:50 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 14:06:50 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 14:06:50 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:06:50 INFO - Return code: 0 14:06:50 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:06:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:06:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:06:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:06:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:06:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MGXW8r5bSNu7I7p_gcE95g/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0209', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 14:06:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MGXW8r5bSNu7I7p_gcE95g/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0209 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 14:06:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KoyyRUu6cI/Render', 14:06:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:06:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:06:50 INFO - 'HOME': '/Users/cltbld', 14:06:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:06:50 INFO - 'LOGNAME': 'cltbld', 14:06:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:06:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:06:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:06:50 INFO - 'MOZ_NO_REMOTE': '1', 14:06:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:06:50 INFO - 'NO_EM_RESTART': '1', 14:06:50 INFO - 'PAGER': '/bin/cat', 14:06:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:06:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:06:50 INFO - 'PWD': '/builds/slave/test', 14:06:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:06:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:06:50 INFO - 'SHELL': '/bin/bash', 14:06:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iCaWgT6dWO/Listeners', 14:06:50 INFO - 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', 14:06:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:06:50 INFO - 'USER': 'cltbld', 14:06:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:06:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:06:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:06:50 INFO - 'XPC_FLAGS': '0x0', 14:06:50 INFO - 'XPC_SERVICE_NAME': '0', 14:06:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:06:50 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MGXW8r5bSNu7I7p_gcE95g/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0209', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 14:06:51 INFO - mozversion application_buildid: 20170330120906 14:06:51 INFO - mozversion application_changeset: 0a36cc120d6e7b8bc19176f5efac6b00dd9ad072 14:06:51 INFO - mozversion application_display_name: Firefox 14:06:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:06:51 INFO - mozversion application_name: Firefox 14:06:51 INFO - mozversion application_remotingname: firefox 14:06:51 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 14:06:51 INFO - mozversion application_vendor: Mozilla 14:06:51 INFO - mozversion application_version: 53.0 14:06:51 INFO - mozversion platform_buildid: 20170330120906 14:06:51 INFO - mozversion platform_changeset: 0a36cc120d6e7b8bc19176f5efac6b00dd9ad072 14:06:51 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 14:06:51 INFO - mozversion platform_version: 53.0 14:06:51 INFO - using testdate: 1490908011 14:06:51 INFO - actual date: 1490908011 14:06:51 INFO - starting webserver on 'localhost:58772' 14:06:51 INFO - SUITE-START | Running 2 tests 14:06:51 INFO - TEST-START | dromaeo_css 14:06:51 INFO - operating with platform_type : mac_ 14:06:51 INFO - Initialising browser for dromaeo_css test... 14:06:51 INFO - TEST-INFO | started process 2517 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/tmpJYvqsY/profile http://localhost:58772/getInfo.html) 14:06:53 INFO - PROCESS | 2517 | 2017-03-30 14:06:53.862 plugin-container[2520:32758] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b3f, name = 'com.apple.tsm.portname' 14:06:53 INFO - PROCESS | 2517 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:06:53 INFO - PROCESS | 2517 | 2017-03-30 14:06:53.862 plugin-container[2520:32758] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4d07, name = 'com.apple.CFPasteboardClient' 14:06:53 INFO - PROCESS | 2517 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:06:53 INFO - PROCESS | 2517 | 2017-03-30 14:06:53.862 plugin-container[2520:32758] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:06:53 INFO - PROCESS | 2517 | __metrics Screen width/height:1600/1200 14:06:53 INFO - PROCESS | 2517 | colorDepth:24 14:06:53 INFO - PROCESS | 2517 | Browser inner width/height: 1024/689 14:06:53 INFO - PROCESS | 2517 | __metrics 14:06:54 ERROR - PROCESS | 2517 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3277: TypeError: this.tabs is undefined 14:06:54 INFO - TEST-INFO | 2517: exit 0 14:06:54 INFO - Browser initialized. 14:06:54 INFO - Running cycle 1/1 for dromaeo_css test... 14:06:54 INFO - TEST-INFO | started process 2521 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/tmpJYvqsY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:06:57 INFO - PROCESS | 2521 | 2017-03-30 14:06:57.168 plugin-container[2522:32886] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4647, name = 'com.apple.tsm.portname' 14:06:57 INFO - PROCESS | 2521 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:06:57 INFO - PROCESS | 2521 | 2017-03-30 14:06:57.169 plugin-container[2522:32886] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8723, name = 'com.apple.CFPasteboardClient' 14:06:57 INFO - PROCESS | 2521 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:06:57 INFO - PROCESS | 2521 | 2017-03-30 14:06:57.169 plugin-container[2522:32886] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:07:06 INFO - PROCESS | 2521 | RSS: Main: 173191168 14:07:06 INFO - PROCESS | 2521 | 14:10:08 INFO - PROCESS | 2521 | Cycle 1(1): loaded http://localhost:58772/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58772/tests/dromaeo/cssquery-ext.html) 14:10:10 INFO - PROCESS | 2521 | RSS: Main: 189050880 14:10:10 INFO - PROCESS | 2521 | 14:13:12 INFO - PROCESS | 2521 | Cycle 1(1): loaded http://localhost:58772/tests/dromaeo/cssquery-ext.html (next: http://localhost:58772/tests/dromaeo/cssquery-jquery.html) 14:13:13 INFO - PROCESS | 2521 | RSS: Main: 201261056 14:13:13 INFO - PROCESS | 2521 | 14:16:15 INFO - PROCESS | 2521 | Cycle 1(1): loaded http://localhost:58772/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58772/tests/dromaeo/cssquery-mootools.html) 14:16:15 INFO - PROCESS | 2521 | RSS: Main: 202862592 14:16:15 INFO - PROCESS | 2521 | 14:19:17 INFO - PROCESS | 2521 | Cycle 1(1): loaded http://localhost:58772/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58772/tests/dromaeo/cssquery-prototype.html) 14:19:18 INFO - PROCESS | 2521 | RSS: Main: 206430208 14:19:18 INFO - PROCESS | 2521 | 14:22:20 INFO - PROCESS | 2521 | Cycle 1(1): loaded http://localhost:58772/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58772/tests/dromaeo/cssquery-yui.html) 14:22:21 INFO - PROCESS | 2521 | RSS: Main: 207601664 14:22:21 INFO - PROCESS | 2521 | 14:25:24 INFO - PROCESS | 2521 | Cycle 1(1): loaded http://localhost:58772/tests/dromaeo/cssquery-yui.html (next: http://localhost:58772/tests/dromaeo/cssquery-dojo.html) 14:25:24 INFO - PROCESS | 2521 | RSS: Main: 211451904 14:25:24 INFO - PROCESS | 2521 | 14:25:24 INFO - PROCESS | 2521 | __start_tp_report 14:25:24 INFO - PROCESS | 2521 | _x_x_mozilla_page_load 14:25:24 INFO - PROCESS | 2521 | _x_x_mozilla_page_load_details 14:25:24 INFO - PROCESS | 2521 | |i|pagename|runs| 14:25:24 INFO - PROCESS | 2521 | |0;dojo.html;3418.1967237699137;3447.1554469155044;3449.3101379724058;3470.8785192518267;3486.546748922641;5857.179994800726;5877.41225877412;5885.440883116108;5961.910571341434;5987.191729116568;4763.404574428197;5952.7916522921705;5974.133750606159;6018.007028840247;6026.939730602693;5264.341957255334;5339.22581225722;5352.812651557197;5377.784888604451;5394.6493477924005;5368.141097424413;5388.407275199725;5393.1101368274385;5408.4050754416985;5430.619856610039;5254.21186821976;5259.710715910624;5384.3807962084275;5386.434424385442;5392.325959255093;5305.204219367107;5308.124159513656;5357.651752636066;5374.892502149935;5431.131019036935;4440.955590444087;5218.817341393033;5343.091674415358;5379.542738867201;5392.56859451243;4817.3737414136285;4954;5765.221695071195;5995.2206213192;6108.3280839107665;5183.844484665466;6248;6249.625022498619;6270.184875966095;6270.529710271702;6319.905201421982;6339.239291285029;6341.143945567382;6341.8097457076365;6368.140301059344;6063;6065.636061836304;6073.696315184223;6086.847828804227;6097.69511524422;5921.230240068763;6032.276126864805;6300.527460440485;6349.555531112777;6432.4532414744335;6222.439980401695;6271.184745982993;6291.276503202191;6306.716197771019;6324.6521441321165;6003.5797494174985;6350;6355.904661430082;6378.585391949508;6384.3934826191435;6208.099825525273;6214.906776398358;6235.75056997715;6274.843128921813;6316.905246421307;6229.065640154013;6247.656378899204;6262.655553944485;6267.6866156692895;6297.905531417033;4295.78521073945;4341.630961368319;5104.081265372194;5123.615728820353;5130.204818253177;4387.6270517006415;4445.444319460067;4455.487618923865;4541.84103556374;4547.3406356078185;5944.138099975479;6002.129691194752;6040.637561746222;6057.818265452043;6101.786437474756;6400.741652669342;6430.164078669743;6436.871262574816;6437.485001199892;6443.6455994920725;5942.64344139353;5998.760049597967;6012.789552365646;6019.819405417845;6051.122587224828;5661.631993920382;5664.433556644302;5665.716714164275;5678.14827775837;5690.886182276331;6582.078509008743;6607.57050791697;6609.801705948829;6614.768483103165;6622.337766223339;6179.6910154493;6261.405166509175;6300.338464461349;6300.936990630035;6377.840553986188;6566.967165164144;6586.275509693834;6593.80218593443;6598.1422415085735;6599.373059559334;6319.178506794087;6324.494040476843;6326.905096423649;6329.019002054689;6337.176167098248;6202.038684003986;6254.906176407449;6271.310155882758;6352.174217351715;6440.033994900802;4757.905681693299;6137.478314343331;6174.475169610454;6269.62382257066;6270.905936411049;6253.78111766086;6253.937460625336;6277.340879207617;6280.780172693934;6294.8111556653375;5885.47030767233;5968.701564921824;5969.701514924323;6172.9074063889975;6221.782237621662;5678.233438485751;6192.59748116389;6250.9062364065485;6263.561550691408;6290;6210.5652604319075;6211;6211.09939058843;6218.253809542884;6235.532335074797 14:25:24 INFO - PROCESS | 2521 | |1;ext.html;465.2253997094837;494.8490710333348;500.9499050094991;505.20430322242464;591.8313280714997;41196.79401602992;43731.344029839536;43992.78003609985;44053.23787048518;44163.55836441635;45402.54597454025;45912;45959.08081838361;46107.308390374084;46212.306815397715;9029.864552031724;9267.119623635745;9536.904630953706;9748.95125524375;9780.706578802612;11711.238769479956;12103.455344509519;12138.211016283913;12179.086568507353;12303.446344914455;12049.518019279261;12070.215435996632;12094.455749491293;12105.27368357897;12113.939430302837;10111.494425278743;12014.339211343373;12021.699457513545;12086;12109.878901210963;11867.52529898803;11924.761504769942;12024.51901923922;12026.4588093536;12038.939805301005;39225.41161882574;42379.15241695149;43785.56214437847;43835.561644383466;43888.3416748749;3504.474328850693;3595.8381872815526;4162.250794856925;4182.958170418317;4257.3613957906255;29983.850080749675;31658;31669.52495712566;32002;34207.31585368279;3352.1619595101224;3512.1746389598425;3512.209752805624;3556.5732112146447;3565.928681426383;431132.5330120051;498537;505115;508120;509662;68151;68770.999999999;68883.3111668877;68982.65508672525;69158.65420672965;71917;73807.63096184592;73918.6304068487;74064.25935740682;74278.62860685663;17872.463826085237;18386.448406547825;18695.15871785773;18726;18772.436826895217;12780.808287875503;13046;13984.790228146587;14047.157170569799;14112;20019.998000200154;21608.78391216099;22322.330330090124;23153.421164470685;23171.420714482272;7594.848103037908;8707.39048266628;9223.308251881135;9232.584533696;9296.256299496024;802.5345299726145;854.2482615298497;896.3456676626099;901.6663834381321;915.55342558757;32234.791614018843;32602.510962335586;32666.673333266364;32908.50637240443;33158.502622460685;1016.3343010328247;1037.5123691864812;1097.308695521832;1160.6982184632056;1222.4254600337827;15666.843331566766;16137.35450581987;16686.33254669824;16796.664066718597;16806.915965420096;656334;658055;659847;663080;666119;58753.41246587565;58836;59439.70280148571;59605;59651;1468.992655036718;1483.7255107804874;1491.6208647207902;1510.5015344936144;1520.186700115433;29250.561241580966;30764.538531922488;30812.53781193329;31135.065948021595;31470.527942081346;51503.71240719012;51912.96174076573;52024.73987630037;52051.47948520466;52099.739501302254;603742;606795;608605;608615;609535;24903.501929960938;26252.474950500502;27384.45231095327;27615.447691045665;28958.565621516114;44580.55419445764;45004.77497612491;45448.54551454443;45833.312500311855;46079;31321.84339078381;31417.371652566362;31632.367352653277;32317.192070197492;32647.673523264464;32147.67852321447;32333;32710.34579308353;32800.671993279764;34683.82658086693;37980.62019379771;37986.8100659506;38379.616203837606;38597.6140238594;38821.41767873541;32724.345513089127;33081.33837323192;33393;33744.65021399117;34046.65953340534;24456;25797.871010644827;26018.479630407666;26107.608385873846;26350.736492634827 14:25:24 INFO - PROCESS | 2521 | |2;jquery.html;324.8424514110656;325.50848219189015;393.48060560060725;402.3642644621497;430.56297857674446;16172.676546469078;21430.89284553579;21623.783762162373;21744.13023479061;21996.780032199673;17497.825021749777;21809.90950452475;22054;22076.006579703913;22530.211442599513;4739.431268247798;5512.503874651281;5988.281406231247;6165.876682466348;6207.099970504274;4437.64498840092;4645.094206629708;6039.094135879609;6621.668916554153;6885.414739747128;6691.029800678899;6925.826854328657;6958.130233720785;6973.163220413558;6984.860302793941;6657.201135863703;6787.898181527281;6793.218779840332;6806.761763338284;6810.182778066639;4982.103221420143;5833.679147646878;5997.460228579449;6001.909971350433;6014.188084608566;26080.217593472225;26345.20964371072;26385.3403664908;26477.470450591074;26999.32501687454;2834.0222623194963;2891.103757835078;2911.839848808315;2918.4017276458276;2925.9853700731574;13412.79880801779;15548.144852033134;16158.919205404016;16229.59426014359;16334.346626135059;1573.402107199257;1871.897045662488;1879.6710575649342;1890.931623632643;1891.5838515526561;130842;132239.33880330538;133927.66072339346;135228.999999999;135393.3230333842;9806.460644664468;11499.597514087134;11740.765184696258;11805.76388472243;11843.170978031627;12425.565105221274;15009.849901501064;15198.696026079417;15211.239438028055;15243.23783810805;7391.81520461982;8899.777505562413;9052.728418147466;9229.907700923039;9273.165415112673;7522.322990930843;9045.140711632384;9062.04848490912;9149.451032938045;9223.077692230858;6643.40209381158;7333.4866559340335;7404.740834070782;7436.996005539183;7470.514416562906;1704.3353092294014;1793.103448275862;1805.1786437171056;1805.9187336569885;1962.6957821537685;868.1882439918696;873.3580818098692;881.457903389411;883.2007033634571;915.876356691838;18602.81397186011;20921.89539052295;21059.578808423747;21646.458838529164;21951.67072493882;897.8339007283673;927.3786563002805;947.5556352658;954.3271993244746;965.7875267441152;9034.954825225963;11147.21969462146;11187.160962927814;11438.714032149097;11439.828402573969;541083;577136;621362;713691;725383;132770;152056.47943520645;152597.47402526054;152628.23685881498;159552;858.5321000054985;1001.5543083327995;1004.3672486333563;1019.0471908765476;1027.5684212630713;18155.36456224026;19151.71272430887;19156.808431915502;19190.328338508087;19233;47224;58870.82258354723;60401;61265.774684505166;61823;90114.09885901319;90295;91006;92663;92672.53663731639;7495.400367970658;7513.774586762406;7802.141764406025;7824.452288339761;7969.402294827795;12349;12715.237085774514;12841;12947.5468358607;13479.932600336935;9645.565949532429;11383.658490245305;11492.310461372344;11670.358130302575;11831.230969986924;10878.40168790724;10946.233763636468;10959.890401095887;10969.341839489656;11105.444727763741;11659.358735269641;11723;11738.295702257892;11778.293302401884;12176.817347739614;7310.305520975498;7616.961915190389;7644.961775191088;8390.244877961013;8773.912260877565;8243.216894395024;10076.496175191065;11176.944115279697;11396.943015285202;11550.480228389575 14:25:24 INFO - PROCESS | 2521 | |3;mootools.html;1343.8857697095746;1439.4961763382823;1487.5239923224565;1488.7841263016862;1501.2118637715198;6685.565438246511;7004.859902801941;8220.465669731471;8643.09247529009;8665.956670216648;6516.315786842384;8270.007599088103;8285.95857020714;8372;8376.62305196266;2390.725066617335;2412.384841865322;2413.384586930339;2421.055788242587;2425.551273014498;2403.567357875582;2428.077330614364;2434.1480481831395;2438.6220135878966;2439.329184474266;2339.333290012347;2361;2367.3016460144213;2385.2963375804093;2396.760323967598;2383.6305372667266;2390.8087353011715;2411.7347091819884;2416.7704068113503;2418.1294733895784;2372.810175185981;2381.7856392924546;2397.4725560376687;2413.891374888134;2421.5641184586766;8515.57422128891;8579.399442039059;8582;8629.05080441151;8640.827183456297;5244.39689435716;5366.758495867695;5373.489518495776;5398.082326004589;5418.214358917974;2970.3316753730455;3546.184377593142;3580.7493475456727;3648.8358023888723;3675.5221821163345;1237.8205160251714;1242.385019415386;1267.9175853569582;1293.5149319005372;1294.0941341061296;10955.397453140075;11052.060574851066;11052.281601695864;11085.778284434266;11127.443627818577;4605.240880220218;4704.082703872712;4832;4836.879078023077;4876.463589005207;9701;9768.462734549668;9782.51087445625;9793.755156121155;9804.754881127887;5338.3060202173465;5419.3225846769155;5429.864253393618;5453.182022696627;5460.918086228709;3737.9813100934866;4116.506019277646;4403.977980110143;4957.082939656175;4957.628177886673;3996;4022.939655905164;4044.797760111983;4077.408775727503;4088.6729061674996;1304.9086563940432;1311.1739604049387;1318.1432069155126;1327.3761332174056;1329.7739384304691;923.4071227133142;929.6002718830968;944.9480278584743;947.5262368815593;975.7316737897135;5618.073017951992;5683.687397193112;5846.795362162304;5893.941060589425;5995.820125396245;556.5186114011351;564.1256053117651;571.1974675580816;579.7246308003749;584.3718003146635;4027.0939038716056;4100.323446631272;4100.938485922714;4114.567970363129;4170.207660544487;10066.245031622511;10235.181185505291;10244.64143754965;10272.486375681186;10281.4063820108;10028.398296102258;10152.441615711206;10156.898431015743;10226.386416815016;10236.283460157867;7568.243175682388;7949.801254968556;7958;8050.919490805134;8082.070561885458;5742.339630942328;5788.681622510802;5812.622179558315;5820.5925585210325;5979.641221526722;9400.764980875532;9556.665516706882;9564.234861210947;9576.329656924227;9603.663871764455;9333.813323733351;9482.620695172116;9508.857367139637;9591.42451452915;9618.663346782829;7280.0535930328715;7426.443016773872;7459.589722565094;7513.586752728434;7535.359494443033;7950.562719050276;8049.27556519916;8053.436259462016;8119.3098586618435;8135.105138434886;7131.429485641032;7155.069840920647;7165.749198778018;7182.245864184394;7280.781576552712;6989.895151572832;7060.823479413056;7067.6819543119655;7070.540414873017;7097.609631470319;5921.940780592139;6481.384268494486;6522;6533.216014078341;6600.339966003361;4253.553376895381;4971.9005619886675;5077.644564880423;5077.974610126926;5100.923486147785;5035.345405097314;5099.87250318745;5138.794448222029;5179.48205179479;5200.193969934666 14:25:24 INFO - PROCESS | 2521 | |4;prototype.html;318.4967750953494;327.76892290934893;342.2214462098725;369.73861944529347;385.7184255493488;5219.530242278194;5317.175837745146;5466.590005749565;5511.421300763423;5529.668219906808;4085.6293557814774;4641.725554478307;4945.703257804535;5255.369355677314;5429.715022411444;3719.5350581177354;4187.895302617436;4247.893802654928;4269.7404265741525;4286;4160.729552579088;4169.541350451448;4248.426462427564;4280.764557949312;4283.607827456073;3643.9271214575692;4188.371744238359;4189.308764053927;4202.915941681164;4222.662187025031;3533.628968958261;4146.295129827937;4206.663466922639;4216.304309788881;4253.659707223414;3149.401613693391;3743.4571987061995;3757.9665591962157;3778.5465744110606;3780.584135745093;4433.689641725081;4871.318015477836;5085.415177254626;5196;5350.625456218067;4302.23608320587;4889.828855990023;4895.926561101586;4915.156816193928;4938.407391113089;5208.671788693859;5209.739513024371;5218.190720773819;5798.710064496759;5803.459889467422;3460.619331873492;3657.085728567858;3958.960410395888;4083.428320035168;4146.3365861462025;5420.674759514442;5441.830006548572;5976.282846058457;6123.489369358586;6143.784967526115;3635.2729454108753;4189.392538081961;4220.746755194698;4239.0674051708575;4244.72409293395;3728.2357116790995;3997.342431675043;4038.394240863835;4290.764007979591;4294.3558466230315;4168.395167860335;4538.706468656417;4730.692504987165;4731.905361892743;4777.498362671939;5826.73779679907;5874.441928016831;5902.026165682614;5943;5958.553108516879;1167.8832116788253;1192.1224072086325;1272.6500212441467;1304.706441050756;1308.3262120008203;859.7893516088599;882.8057827277988;884.6417201033591;888.7022847346083;892.4734406700078;4447.844325448594;4683.157031734252;4708.352076773171;5163.554204822655;5247.29764171452;4870.707757534559;5166.715830629276;5652.756393593403;5710.314762228559;5773.336066352424;4915.918497930521;4985.850424487271;5015.699058056528;5099.582752454467;5154.845354639367;2309.711286089239;2664.880080396387;2675.224184986332;2942.6174597302215;3032.4086803073187;5470.452954704498;5869.530437564985;5877.294724632986;5931.487470695031;5932.2584676915385;4813.061453016629;5703.233931543198;5781.942180578225;5914.290285165807;5940.405959404112;5554.805581804618;6050.092486127028;6203.4416902479;6223.81328560153;6241.8140553294725;5683.914741278802;6011.489023433057;6013.278406591062;6028.15605815195;6041.69791510414;4677.111348843709;5149.665271757323;5774.902768473977;5860.326062502867;5909.940900590939;4992.951480189201;5457.918131227955;6144.631322120687;6179.907301390393;6256.874862502634;3495.312445370159;3758.6993040557236;3807.2486656138485;3831.7126215534504;3978.661813745864;5061.797528098835;5514.724263786875;5864.706764661664;5925.614835035709;5937.732802024006;4909.759558691247;5323.494268044529;5724.570657200643;5833.912491312549;5848.941510584839;4746.955669752787;4910.582600479;5813.970930145322;5861.208736820475;5863.355030946507;5251.474852514871;5397.973010134924;5657.971710141587;5694.373618901835;5807.709614519342;5760.971195144165;5773.16289138081;5819.5344372450945;5831.475167234969;5844.970775146097;5005.674631148963;5512.944870551243;5712.228849105484;5732.914006289992;5734.254546908875 14:25:24 INFO - PROCESS | 2521 | |5;yui.html;743.6467677853024;750.4971668981782;751.3500821789153;793.8848866914298;888.0675290944507;13591.796123058137;15160.696786064273;15577.376904923789;16310.918445407771;16514.091724955153;11930.761384772299;14993.325300361483;15029.774553381681;15161.772573411408;15181.848181518182;887.0641473245723;898.3980732908934;919.7240827751681;926.9768255793591;928.3037721708719;727.8617062758085;916.3036092569662;917.312015988009;917.8072604752977;920.2729843423688;776.4564804636749;778.696308439709;932.3100905330041;972.7179118055791;978.4129522286606;953.60902030168;953.823542644613;955.6082006377387;958.9808203835919;961.5721004153155;698.8113209433425;705.4180301251488;706.533687766077;710.6979533698158;715.7459102018812;11907.583234586835;12741.554045608453;15724.606884827856;15869.20653967297;15943.760843587355;12478.688032799162;14436.783448248285;15077.958719002107;15230.390784368612;15379.307931143125;11702.356370399624;11888.881111188864;11903;11947.701307467296;12002.219855709438;3900.960990390088;3903.882883513471;3910.237503686754;3939.113699417637;3947.5460322063045;82770;103249.96750032478;103839.48080259626;105211.4739426298;106699.46650266777;11237.550497980154;11374.601888933848;11640.894115059056;11807.645770626896;11841;24080.7591924082;24282.271531854072;24663.876680616482;24678.383040423774;25201.62197567038;7912.248336408032;8066.475679080841;8108.067973131539;8114.715984940499;8162.306203972729;4015.5984401560195;4234.301340278881;4470.396496472935;4505.166544189336;4580.88547786308;3769.453429252743;3845.5577608575372;3852.1910398816003;3855.7108216883844;3870.0324918770307;702.7470110760122;704.1522234694303;719.1765428584242;729.3180875881068;729.4201110117469;698.849747304332;725.6263024542365;727.1020289941918;727.4653129949482;739.7041183526525;10370.688879333633;10634.521446534924;10924.2899211551;11040.503177357039;11167.664970050912;696.8153439338579;719.7516856684435;735.5623404074568;750.3097150621442;750.5459197185625;4626.421697287839;5118.3090282811345;5129.820456284012;5132.204508301219;5140.280360749498;90510;99842;100184;100477;105920.94079059265;78937;79305.20694793094;81748.59125704333;87781;90301;61984.76030479365;70065.64967175132;73722.63138684272;76459;76843.61578192073;9921.900780992097;9924.553395097093;10019.949900250453;10022.899771002196;10056.497175141067;32125.678743213204;51866;52224.738876305375;52324.21513677222;53315;65100.348996511326;66751;67629.9855502158;70522.29477705363;70546.29453705397;13180.80228796588;13368.264745439094;13416.329183540589;13860.029797914049;13990.230537320545;14712.264386780833;15025.137848716637;15260.847391525942;15288.617784555476;15320.157391343137;13781.793273100711;13911.652208694864;13965.441382345;14220.928895355457;14411.207383594003;14039.789403159166;14068.507602233873;14261;14294.142351458946;14873.776893346392;13616.795748063985;14122.50571230002;14127.505537306144;14167.574972750834;14193.574192774233;9350.392224505385;9733.124018838338;9860.26048046385;9921.801563968536;9940.304178707422;9748.805023899624;11262.774744505228;11371.54513819438;11567.132465064986;11790.94104529472 14:25:24 INFO - PROCESS | 2521 | __end_tp_report 14:25:24 INFO - PROCESS | 2521 | __start_cc_report 14:25:24 INFO - PROCESS | 2521 | _x_x_mozilla_cycle_collect,375 14:25:24 INFO - PROCESS | 2521 | __end_cc_report 14:25:24 INFO - PROCESS | 2521 | __startTimestamp1490909124420__endTimestamp 14:25:24 INFO - PROCESS | 2521 | 14:25:24 INFO - PROCESS | 2521 | ------- Summary: start ------- 14:25:24 INFO - PROCESS | 2521 | Number of tests: 6 14:25:24 INFO - PROCESS | 2521 | 14:25:24 INFO - PROCESS | 2521 | [#0] dojo.html Cycles:165 Average:5851.68 Median:6101.79 stddev:689.38 (11.3%) stddev-sans-first:664.53 14:25:24 INFO - PROCESS | 2521 | Values: 3418.2 3447.2 3449.3 3470.9 3486.5 5857.2 5877.4 5885.4 5961.9 5987.2 4763.4 5952.8 5974.1 6018.0 6026.9 5264.3 5339.2 5352.8 5377.8 5394.6 5368.1 5388.4 5393.1 5408.4 5430.6 5254.2 5259.7 5384.4 5386.4 5392.3 5305.2 5308.1 5357.7 5374.9 5431.1 4441.0 5218.8 5343.1 5379.5 5392.6 4817.4 4954.0 5765.2 5995.2 6108.3 5183.8 6248.0 6249.6 6270.2 6270.5 6319.9 6339.2 6341.1 6341.8 6368.1 6063.0 6065.6 6073.7 6086.8 6097.7 5921.2 6032.3 6300.5 6349.6 6432.5 6222.4 6271.2 6291.3 6306.7 6324.7 6003.6 6350.0 6355.9 6378.6 6384.4 6208.1 6214.9 6235.8 6274.8 6316.9 6229.1 6247.7 6262.7 6267.7 6297.9 4295.8 4341.6 5104.1 5123.6 5130.2 4387.6 4445.4 4455.5 4541.8 4547.3 5944.1 6002.1 6040.6 6057.8 6101.8 6400.7 6430.2 6436.9 6437.5 6443.6 5942.6 5998.8 6012.8 6019.8 6051.1 5661.6 5664.4 5665.7 5678.1 5690.9 6582.1 6607.6 6609.8 6614.8 6622.3 6179.7 6261.4 6300.3 6300.9 6377.8 6567.0 6586.3 6593.8 6598.1 6599.4 6319.2 6324.5 6326.9 6329.0 6337.2 6202.0 6254.9 6271.3 6352.2 6440.0 4757.9 6137.5 6174.5 6269.6 6270.9 6253.8 6253.9 6277.3 6280.8 6294.8 5885.5 5968.7 5969.7 6172.9 6221.8 5678.2 6192.6 6250.9 6263.6 6290.0 6210.6 6211.0 6211.1 6218.3 6235.5 14:25:24 INFO - PROCESS | 2521 | 14:25:24 INFO - PROCESS | 2521 | [#1] ext.html Cycles:180 Average:72841.55 Median:19094.15 stddev:157797.58 (826.4%) stddev-sans-first:158146.68 14:25:24 INFO - PROCESS | 2521 | Values: 465.2 494.8 500.9 505.2 591.8 41196.8 43731.3 43992.8 44053.2 44163.6 45402.5 45912.0 45959.1 46107.3 46212.3 9029.9 9267.1 9536.9 9749.0 9780.7 11711.2 12103.5 12138.2 12179.1 12303.4 12049.5 12070.2 12094.5 12105.3 12113.9 10111.5 12014.3 12021.7 12086.0 12109.9 11867.5 11924.8 12024.5 12026.5 12038.9 39225.4 42379.2 43785.6 43835.6 43888.3 3504.5 3595.8 4162.3 4183.0 4257.4 29983.9 31658.0 31669.5 32002.0 34207.3 3352.2 3512.2 3512.2 3556.6 3565.9 431132.5 498537.0 505115.0 508120.0 509662.0 68151.0 68771.0 68883.3 68982.7 69158.7 71917.0 73807.6 73918.6 74064.3 74278.6 17872.5 18386.4 18695.2 18726.0 18772.4 12780.8 13046.0 13984.8 14047.2 14112.0 20020.0 21608.8 22322.3 23153.4 23171.4 7594.8 8707.4 9223.3 9232.6 9296.3 802.5 854.2 896.3 901.7 915.6 32234.8 32602.5 32666.7 32908.5 33158.5 1016.3 1037.5 1097.3 1160.7 1222.4 15666.8 16137.4 16686.3 16796.7 16806.9 656334.0 658055.0 659847.0 663080.0 666119.0 58753.4 58836.0 59439.7 59605.0 59651.0 1469.0 1483.7 1491.6 1510.5 1520.2 29250.6 30764.5 30812.5 31135.1 31470.5 51503.7 51913.0 52024.7 52051.5 52099.7 603742.0 606795.0 608605.0 608615.0 609535.0 24903.5 26252.5 27384.5 27615.4 28958.6 44580.6 45004.8 45448.5 45833.3 46079.0 31321.8 31417.4 31632.4 32317.2 32647.7 32147.7 32333.0 32710.3 32800.7 34683.8 37980.6 37986.8 38379.6 38597.6 38821.4 32724.3 33081.3 33393.0 33744.7 34046.7 24456.0 25797.9 26018.5 26107.6 26350.7 14:25:24 INFO - PROCESS | 2521 | 14:25:24 INFO - PROCESS | 2521 | [#2] jquery.html Cycles:180 Average:37980.41 Median:2862.56 stddev:107533.93 (3756.6%) stddev-sans-first:107798.42 14:25:24 INFO - PROCESS | 2521 | Values: 324.8 325.5 393.5 402.4 430.6 16172.7 21430.9 21623.8 21744.1 21996.8 17497.8 21809.9 22054.0 22076.0 22530.2 4739.4 5512.5 5988.3 6165.9 6207.1 4437.6 4645.1 6039.1 6621.7 6885.4 6691.0 6925.8 6958.1 6973.2 6984.9 6657.2 6787.9 6793.2 6806.8 6810.2 4982.1 5833.7 5997.5 6001.9 6014.2 26080.2 26345.2 26385.3 26477.5 26999.3 2834.0 2891.1 2911.8 2918.4 2926.0 13412.8 15548.1 16158.9 16229.6 16334.3 1573.4 1871.9 1879.7 1890.9 1891.6 130842.0 132239.3 133927.7 135229.0 135393.3 9806.5 11499.6 11740.8 11805.8 11843.2 12425.6 15009.8 15198.7 15211.2 15243.2 7391.8 8899.8 9052.7 9229.9 9273.2 7522.3 9045.1 9062.0 9149.5 9223.1 6643.4 7333.5 7404.7 7437.0 7470.5 1704.3 1793.1 1805.2 1805.9 1962.7 868.2 873.4 881.5 883.2 915.9 18602.8 20921.9 21059.6 21646.5 21951.7 897.8 927.4 947.6 954.3 965.8 9035.0 11147.2 11187.2 11438.7 11439.8 541083.0 577136.0 621362.0 713691.0 725383.0 132770.0 152056.5 152597.5 152628.2 159552.0 858.5 1001.6 1004.4 1019.0 1027.6 18155.4 19151.7 19156.8 19190.3 19233.0 47224.0 58870.8 60401.0 61265.8 61823.0 90114.1 90295.0 91006.0 92663.0 92672.5 7495.4 7513.8 7802.1 7824.5 7969.4 12349.0 12715.2 12841.0 12947.5 13479.9 9645.6 11383.7 11492.3 11670.4 11831.2 10878.4 10946.2 10959.9 10969.3 11105.4 11659.4 11723.0 11738.3 11778.3 12176.8 7310.3 7617.0 7645.0 8390.2 8773.9 8243.2 10076.5 11176.9 11396.9 11550.5 14:25:24 INFO - PROCESS | 2521 | 14:25:24 INFO - PROCESS | 2521 | [#3] mootools.html Cycles:180 Average:5543.80 Median:5291.35 stddev:3017.43 (57.0%) stddev-sans-first:3009.38 14:25:24 INFO - PROCESS | 2521 | Values: 1343.9 1439.5 1487.5 1488.8 1501.2 6685.6 7004.9 8220.5 8643.1 8666.0 6516.3 8270.0 8286.0 8372.0 8376.6 2390.7 2412.4 2413.4 2421.1 2425.6 2403.6 2428.1 2434.1 2438.6 2439.3 2339.3 2361.0 2367.3 2385.3 2396.8 2383.6 2390.8 2411.7 2416.8 2418.1 2372.8 2381.8 2397.5 2413.9 2421.6 8515.6 8579.4 8582.0 8629.1 8640.8 5244.4 5366.8 5373.5 5398.1 5418.2 2970.3 3546.2 3580.7 3648.8 3675.5 1237.8 1242.4 1267.9 1293.5 1294.1 10955.4 11052.1 11052.3 11085.8 11127.4 4605.2 4704.1 4832.0 4836.9 4876.5 9701.0 9768.5 9782.5 9793.8 9804.8 5338.3 5419.3 5429.9 5453.2 5460.9 3738.0 4116.5 4404.0 4957.1 4957.6 3996.0 4022.9 4044.8 4077.4 4088.7 1304.9 1311.2 1318.1 1327.4 1329.8 923.4 929.6 944.9 947.5 975.7 5618.1 5683.7 5846.8 5893.9 5995.8 556.5 564.1 571.2 579.7 584.4 4027.1 4100.3 4100.9 4114.6 4170.2 10066.2 10235.2 10244.6 10272.5 10281.4 10028.4 10152.4 10156.9 10226.4 10236.3 7568.2 7949.8 7958.0 8050.9 8082.1 5742.3 5788.7 5812.6 5820.6 5979.6 9400.8 9556.7 9564.2 9576.3 9603.7 9333.8 9482.6 9508.9 9591.4 9618.7 7280.1 7426.4 7459.6 7513.6 7535.4 7950.6 8049.3 8053.4 8119.3 8135.1 7131.4 7155.1 7165.7 7182.2 7280.8 6989.9 7060.8 7067.7 7070.5 7097.6 5921.9 6481.4 6522.0 6533.2 6600.3 4253.6 4971.9 5077.6 5078.0 5100.9 5035.3 5099.9 5138.8 5179.5 5200.2 14:25:24 INFO - PROCESS | 2521 | 14:25:24 INFO - PROCESS | 2521 | [#4] prototype.html Cycles:180 Average:4627.73 Median:5092.50 stddev:1431.51 (28.1%) stddev-sans-first:1398.51 14:25:24 INFO - PROCESS | 2521 | Values: 318.5 327.8 342.2 369.7 385.7 5219.5 5317.2 5466.6 5511.4 5529.7 4085.6 4641.7 4945.7 5255.4 5429.7 3719.5 4187.9 4247.9 4269.7 4286.0 4160.7 4169.5 4248.4 4280.8 4283.6 3643.9 4188.4 4189.3 4202.9 4222.7 3533.6 4146.3 4206.7 4216.3 4253.7 3149.4 3743.5 3758.0 3778.5 3780.6 4433.7 4871.3 5085.4 5196.0 5350.6 4302.2 4889.8 4895.9 4915.2 4938.4 5208.7 5209.7 5218.2 5798.7 5803.5 3460.6 3657.1 3959.0 4083.4 4146.3 5420.7 5441.8 5976.3 6123.5 6143.8 3635.3 4189.4 4220.7 4239.1 4244.7 3728.2 3997.3 4038.4 4290.8 4294.4 4168.4 4538.7 4730.7 4731.9 4777.5 5826.7 5874.4 5902.0 5943.0 5958.6 1167.9 1192.1 1272.7 1304.7 1308.3 859.8 882.8 884.6 888.7 892.5 4447.8 4683.2 4708.4 5163.6 5247.3 4870.7 5166.7 5652.8 5710.3 5773.3 4915.9 4985.9 5015.7 5099.6 5154.8 2309.7 2664.9 2675.2 2942.6 3032.4 5470.5 5869.5 5877.3 5931.5 5932.3 4813.1 5703.2 5781.9 5914.3 5940.4 5554.8 6050.1 6203.4 6223.8 6241.8 5683.9 6011.5 6013.3 6028.2 6041.7 4677.1 5149.7 5774.9 5860.3 5909.9 4993.0 5457.9 6144.6 6179.9 6256.9 3495.3 3758.7 3807.2 3831.7 3978.7 5061.8 5514.7 5864.7 5925.6 5937.7 4909.8 5323.5 5724.6 5833.9 5848.9 4747.0 4910.6 5814.0 5861.2 5863.4 5251.5 5398.0 5658.0 5694.4 5807.7 5761.0 5773.2 5819.5 5831.5 5845.0 5005.7 5512.9 5712.2 5732.9 5734.3 14:25:24 INFO - PROCESS | 2521 | 14:25:24 INFO - PROCESS | 2521 | [#5] yui.html Cycles:180 Average:20108.21 Median:4124.95 stddev:28013.46 (679.1%) stddev-sans-first:28054.31 14:25:24 INFO - PROCESS | 2521 | Values: 743.6 750.5 751.4 793.9 888.1 13591.8 15160.7 15577.4 16310.9 16514.1 11930.8 14993.3 15029.8 15161.8 15181.8 887.1 898.4 919.7 927.0 928.3 727.9 916.3 917.3 917.8 920.3 776.5 778.7 932.3 972.7 978.4 953.6 953.8 955.6 959.0 961.6 698.8 705.4 706.5 710.7 715.7 11907.6 12741.6 15724.6 15869.2 15943.8 12478.7 14436.8 15078.0 15230.4 15379.3 11702.4 11888.9 11903.0 11947.7 12002.2 3901.0 3903.9 3910.2 3939.1 3947.5 82770.0 103250.0 103839.5 105211.5 106699.5 11237.6 11374.6 11640.9 11807.6 11841.0 24080.8 24282.3 24663.9 24678.4 25201.6 7912.2 8066.5 8108.1 8114.7 8162.3 4015.6 4234.3 4470.4 4505.2 4580.9 3769.5 3845.6 3852.2 3855.7 3870.0 702.7 704.2 719.2 729.3 729.4 698.8 725.6 727.1 727.5 739.7 10370.7 10634.5 10924.3 11040.5 11167.7 696.8 719.8 735.6 750.3 750.5 4626.4 5118.3 5129.8 5132.2 5140.3 90510.0 99842.0 100184.0 100477.0 105920.9 78937.0 79305.2 81748.6 87781.0 90301.0 61984.8 70065.6 73722.6 76459.0 76843.6 9921.9 9924.6 10019.9 10022.9 10056.5 32125.7 51866.0 52224.7 52324.2 53315.0 65100.3 66751.0 67630.0 70522.3 70546.3 13180.8 13368.3 13416.3 13860.0 13990.2 14712.3 15025.1 15260.8 15288.6 15320.2 13781.8 13911.7 13965.4 14220.9 14411.2 14039.8 14068.5 14261.0 14294.1 14873.8 13616.8 14122.5 14127.5 14167.6 14193.6 9350.4 9733.1 9860.3 9921.8 9940.3 9748.8 11262.8 11371.5 11567.1 11790.9 14:25:24 INFO - PROCESS | 2521 | -------- Summary: end -------- 14:25:24 INFO - PROCESS | 2521 | 14:25:24 INFO - TEST-INFO | 2521: exit 0 14:25:25 INFO - TEST-OK | dromaeo_css | took 1113831ms 14:25:25 INFO - TEST-START | kraken 14:25:25 INFO - operating with platform_type : mac_ 14:25:25 INFO - Initialising browser for kraken test... 14:25:25 INFO - TEST-INFO | started process 2528 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/tmp3bMQJI/profile http://localhost:58772/getInfo.html) 14:25:27 INFO - PROCESS | 2528 | 2017-03-30 14:25:27.727 plugin-container[2530:34874] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4243, name = 'com.apple.tsm.portname' 14:25:27 INFO - PROCESS | 2528 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:25:27 INFO - PROCESS | 2528 | 2017-03-30 14:25:27.728 plugin-container[2530:34874] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c0b, name = 'com.apple.CFPasteboardClient' 14:25:27 INFO - PROCESS | 2528 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:25:27 INFO - PROCESS | 2528 | 2017-03-30 14:25:27.728 plugin-container[2530:34874] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:25:27 INFO - PROCESS | 2528 | __metrics Screen width/height:1600/1200 14:25:27 INFO - PROCESS | 2528 | colorDepth:24 14:25:27 INFO - PROCESS | 2528 | Browser inner width/height: 1024/689 14:25:27 INFO - PROCESS | 2528 | __metrics 14:25:27 ERROR - PROCESS | 2528 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3277: TypeError: this.tabs is undefined 14:25:28 INFO - TEST-INFO | 2528: exit 0 14:25:28 INFO - Browser initialized. 14:25:28 INFO - Running cycle 1/1 for kraken test... 14:25:28 INFO - TEST-INFO | started process 2531 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/tmp3bMQJI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:25:30 INFO - PROCESS | 2531 | 2017-03-30 14:25:30.731 plugin-container[2532:34998] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4343, name = 'com.apple.tsm.portname' 14:25:30 INFO - PROCESS | 2531 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:25:30 INFO - PROCESS | 2531 | 2017-03-30 14:25:30.732 plugin-container[2532:34998] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b13, name = 'com.apple.CFPasteboardClient' 14:25:30 INFO - PROCESS | 2531 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:25:30 INFO - PROCESS | 2531 | 2017-03-30 14:25:30.732 plugin-container[2532:34998] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:25:40 INFO - PROCESS | 2531 | RSS: Main: 173404160 14:25:40 INFO - PROCESS | 2531 | 14:25:43 INFO - PROCESS | 2531 | Cycle 1(1): loaded http://localhost:58772/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58772/tests/kraken/driver.html?testName=audio-beat-detection) 14:25:44 INFO - PROCESS | 2531 | RSS: Main: 186339328 14:25:44 INFO - PROCESS | 2531 | 14:25:46 INFO - PROCESS | 2531 | Cycle 1(1): loaded http://localhost:58772/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58772/tests/kraken/driver.html?testName=audio-dft) 14:25:47 INFO - PROCESS | 2531 | RSS: Main: 194850816 14:25:47 INFO - PROCESS | 2531 | 14:25:50 INFO - PROCESS | 2531 | Cycle 1(1): loaded http://localhost:58772/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58772/tests/kraken/driver.html?testName=audio-fft) 14:25:51 INFO - PROCESS | 2531 | RSS: Main: 198180864 14:25:51 INFO - PROCESS | 2531 | 14:25:53 INFO - PROCESS | 2531 | Cycle 1(1): loaded http://localhost:58772/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58772/tests/kraken/driver.html?testName=audio-oscillator) 14:25:54 INFO - PROCESS | 2531 | RSS: Main: 198033408 14:25:54 INFO - PROCESS | 2531 | 14:25:56 INFO - PROCESS | 2531 | Cycle 1(1): loaded http://localhost:58772/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58772/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:25:56 INFO - PROCESS | 2531 | RSS: Main: 198049792 14:25:56 INFO - PROCESS | 2531 | 14:25:59 INFO - PROCESS | 2531 | Cycle 1(1): loaded http://localhost:58772/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58772/tests/kraken/driver.html?testName=imaging-darkroom) 14:26:00 INFO - PROCESS | 2531 | RSS: Main: 204148736 14:26:00 INFO - PROCESS | 2531 | 14:26:03 INFO - PROCESS | 2531 | Cycle 1(1): loaded http://localhost:58772/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58772/tests/kraken/driver.html?testName=imaging-desaturate) 14:26:03 INFO - PROCESS | 2531 | RSS: Main: 203702272 14:26:03 INFO - PROCESS | 2531 | 14:26:07 INFO - PROCESS | 2531 | Cycle 1(1): loaded http://localhost:58772/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58772/tests/kraken/driver.html?testName=json-parse-financial) 14:26:07 INFO - PROCESS | 2531 | RSS: Main: 203018240 14:26:07 INFO - PROCESS | 2531 | 14:26:09 INFO - PROCESS | 2531 | Cycle 1(1): loaded http://localhost:58772/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58772/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:26:09 INFO - PROCESS | 2531 | RSS: Main: 201875456 14:26:09 INFO - PROCESS | 2531 | 14:26:11 INFO - PROCESS | 2531 | Cycle 1(1): loaded http://localhost:58772/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58772/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:26:12 INFO - PROCESS | 2531 | RSS: Main: 202317824 14:26:12 INFO - PROCESS | 2531 | 14:26:14 INFO - PROCESS | 2531 | Cycle 1(1): loaded http://localhost:58772/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58772/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:26:15 INFO - PROCESS | 2531 | RSS: Main: 202375168 14:26:15 INFO - PROCESS | 2531 | 14:26:18 INFO - PROCESS | 2531 | Cycle 1(1): loaded http://localhost:58772/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58772/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:26:18 INFO - PROCESS | 2531 | RSS: Main: 202366976 14:26:18 INFO - PROCESS | 2531 | 14:26:21 INFO - PROCESS | 2531 | Cycle 1(1): loaded http://localhost:58772/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58772/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:26:22 INFO - PROCESS | 2531 | RSS: Main: 202760192 14:26:22 INFO - PROCESS | 2531 | 14:26:24 INFO - PROCESS | 2531 | Cycle 1(1): loaded http://localhost:58772/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58772/tests/kraken/driver.html?testName=ai-astar) 14:26:24 INFO - PROCESS | 2531 | RSS: Main: 204197888 14:26:24 INFO - PROCESS | 2531 | 14:26:24 INFO - PROCESS | 2531 | __start_tp_report 14:26:24 INFO - PROCESS | 2531 | _x_x_mozilla_page_load 14:26:24 INFO - PROCESS | 2531 | _x_x_mozilla_page_load_details 14:26:24 INFO - PROCESS | 2531 | |i|pagename|runs| 14:26:24 INFO - PROCESS | 2531 | |0;ai-astar;103;118;119;118;117;117;117;116;118;119 14:26:24 INFO - PROCESS | 2531 | |1;audio-beat-detection;142;107;141;183;141;110;111;107;129;112 14:26:24 INFO - PROCESS | 2531 | |2;audio-dft;195;204;194;233;223;197;199;198;217;177 14:26:24 INFO - PROCESS | 2531 | |3;audio-fft;76;61;59;93;79;52;50;60;83;84 14:26:24 INFO - PROCESS | 2531 | |4;audio-oscillator;84;71;85;74;69;70;78;71;75;102 14:26:24 INFO - PROCESS | 2531 | |5;imaging-gaussian-blur;101;131;88;86;89;86;90;107;89;86 14:26:24 INFO - PROCESS | 2531 | |6;imaging-darkroom;94;102;96;126;99;142;155;107;95;95 14:26:24 INFO - PROCESS | 2531 | |7;imaging-desaturate;143;104;113;129;147;114;94;93;103;77 14:26:24 INFO - PROCESS | 2531 | |8;json-parse-financial;58;61;58;61;63;61;62;62;61;62 14:26:24 INFO - PROCESS | 2531 | |9;json-stringify-tinderbox;71;72;69;83;79;76;68;71;74;87 14:26:24 INFO - PROCESS | 2531 | |10;stanford-crypto-aes;86;82;85;83;81;82;82;90;83;82 14:26:24 INFO - PROCESS | 2531 | |11;stanford-crypto-ccm;138;150;149;160;153;130;138;140;210;171 14:26:24 INFO - PROCESS | 2531 | |12;stanford-crypto-pbkdf2;166;188;166;165;183;226;210;166;163;165 14:26:24 INFO - PROCESS | 2531 | |13;stanford-crypto-sha256-iterative;65;67;66;70;89;95;57;76;85;91 14:26:24 INFO - PROCESS | 2531 | __end_tp_report 14:26:24 INFO - PROCESS | 2531 | __start_cc_report 14:26:24 INFO - PROCESS | 2531 | _x_x_mozilla_cycle_collect,935 14:26:24 INFO - PROCESS | 2531 | __end_cc_report 14:26:24 INFO - PROCESS | 2531 | __startTimestamp1490909184507__endTimestamp 14:26:24 INFO - PROCESS | 2531 | 14:26:24 INFO - PROCESS | 2531 | ------- Summary: start ------- 14:26:24 INFO - PROCESS | 2531 | Number of tests: 14 14:26:24 INFO - PROCESS | 2531 | 14:26:24 INFO - PROCESS | 2531 | [#0] ai-astar Cycles:10 Average:116.20 Median:118.00 stddev:4.73 (4.0%) stddev-sans-first:1.00 14:26:24 INFO - PROCESS | 2531 | Values: 103.0 118.0 119.0 118.0 117.0 117.0 117.0 116.0 118.0 119.0 14:26:24 INFO - PROCESS | 2531 | 14:26:24 INFO - PROCESS | 2531 | [#1] audio-beat-detection Cycles:10 Average:128.30 Median:135.00 stddev:24.29 (18.0%) stddev-sans-first:25.25 14:26:24 INFO - PROCESS | 2531 | Values: 142.0 107.0 141.0 183.0 141.0 110.0 111.0 107.0 129.0 112.0 14:26:24 INFO - PROCESS | 2531 | 14:26:24 INFO - PROCESS | 2531 | [#2] audio-dft Cycles:10 Average:203.70 Median:201.50 stddev:16.30 (8.1%) stddev-sans-first:16.98 14:26:24 INFO - PROCESS | 2531 | Values: 195.0 204.0 194.0 233.0 223.0 197.0 199.0 198.0 217.0 177.0 14:26:24 INFO - PROCESS | 2531 | 14:26:24 INFO - PROCESS | 2531 | [#3] audio-fft Cycles:10 Average:69.70 Median:77.50 stddev:15.04 (19.4%) stddev-sans-first:15.78 14:26:24 INFO - PROCESS | 2531 | Values: 76.0 61.0 59.0 93.0 79.0 52.0 50.0 60.0 83.0 84.0 14:26:24 INFO - PROCESS | 2531 | 14:26:24 INFO - PROCESS | 2531 | [#4] audio-oscillator Cycles:10 Average:77.90 Median:74.50 stddev:10.16 (13.6%) stddev-sans-first:10.53 14:26:24 INFO - PROCESS | 2531 | Values: 84.0 71.0 85.0 74.0 69.0 70.0 78.0 71.0 75.0 102.0 14:26:24 INFO - PROCESS | 2531 | 14:26:24 INFO - PROCESS | 2531 | [#5] imaging-gaussian-blur Cycles:10 Average:95.30 Median:87.00 stddev:14.39 (16.5%) stddev-sans-first:15.12 14:26:24 INFO - PROCESS | 2531 | Values: 101.0 131.0 88.0 86.0 89.0 86.0 90.0 107.0 89.0 86.0 14:26:24 INFO - PROCESS | 2531 | 14:26:24 INFO - PROCESS | 2531 | [#6] imaging-darkroom Cycles:10 Average:111.10 Median:94.50 stddev:22.08 (23.4%) stddev-sans-first:22.54 14:26:24 INFO - PROCESS | 2531 | Values: 94.0 102.0 96.0 126.0 99.0 142.0 155.0 107.0 95.0 95.0 14:26:24 INFO - PROCESS | 2531 | 14:26:24 INFO - PROCESS | 2531 | [#7] imaging-desaturate Cycles:10 Average:111.70 Median:145.00 stddev:22.45 (15.5%) stddev-sans-first:20.75 14:26:24 INFO - PROCESS | 2531 | Values: 143.0 104.0 113.0 129.0 147.0 114.0 94.0 93.0 103.0 77.0 14:26:24 INFO - PROCESS | 2531 | 14:26:24 INFO - PROCESS | 2531 | [#8] json-parse-financial Cycles:10 Average:60.90 Median:61.50 stddev:1.66 (2.7%) stddev-sans-first:1.39 14:26:24 INFO - PROCESS | 2531 | Values: 58.0 61.0 58.0 61.0 63.0 61.0 62.0 62.0 61.0 62.0 14:26:24 INFO - PROCESS | 2531 | 14:26:24 INFO - PROCESS | 2531 | [#9] json-stringify-tinderbox Cycles:10 Average:75.00 Median:75.00 stddev:6.25 (8.3%) stddev-sans-first:6.46 14:26:24 INFO - PROCESS | 2531 | Values: 71.0 72.0 69.0 83.0 79.0 76.0 68.0 71.0 74.0 87.0 14:26:24 INFO - PROCESS | 2531 | 14:26:24 INFO - PROCESS | 2531 | [#10] stanford-crypto-aes Cycles:10 Average:83.60 Median:83.00 stddev:2.72 (3.3%) stddev-sans-first:2.74 14:26:24 INFO - PROCESS | 2531 | Values: 86.0 82.0 85.0 83.0 81.0 82.0 82.0 90.0 83.0 82.0 14:26:24 INFO - PROCESS | 2531 | 14:26:24 INFO - PROCESS | 2531 | [#11] stanford-crypto-ccm Cycles:10 Average:153.90 Median:151.50 stddev:23.06 (15.2%) stddev-sans-first:23.73 14:26:24 INFO - PROCESS | 2531 | Values: 138.0 150.0 149.0 160.0 153.0 130.0 138.0 140.0 210.0 171.0 14:26:24 INFO - PROCESS | 2531 | 14:26:24 INFO - PROCESS | 2531 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.80 Median:174.50 stddev:22.15 (12.7%) stddev-sans-first:22.92 14:26:24 INFO - PROCESS | 2531 | Values: 166.0 188.0 166.0 165.0 183.0 226.0 210.0 166.0 163.0 165.0 14:26:24 INFO - PROCESS | 2531 | 14:26:24 INFO - PROCESS | 2531 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.10 Median:80.50 stddev:13.06 (16.2%) stddev-sans-first:13.22 14:26:24 INFO - PROCESS | 2531 | Values: 65.0 67.0 66.0 70.0 89.0 95.0 57.0 76.0 85.0 91.0 14:26:24 INFO - PROCESS | 2531 | -------- Summary: end -------- 14:26:24 INFO - PROCESS | 2531 | 14:26:25 INFO - TEST-INFO | 2531: exit 0 14:26:25 INFO - TEST-OK | kraken | took 60357ms 14:26:25 INFO - SUITE-END | took 1174s 14:26:25 INFO - Completed test suite (00:19:34) 14:26:25 INFO - javascript benchmark 14:26:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7509.131019679962, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3418.1967237699137, 3447.1554469155044, 3449.3101379724058, 3470.8785192518267, 3486.546748922641, 5857.179994800726, 5877.41225877412, 5885.440883116108, 5961.910571341434, 5987.191729116568, 4763.404574428197, 5952.7916522921705, 5974.133750606159, 6018.007028840247, 6026.939730602693, 5264.341957255334, 5339.22581225722, 5352.812651557197, 5377.784888604451, 5394.6493477924005, 5368.141097424413, 5388.407275199725, 5393.1101368274385, 5408.4050754416985, 5430.619856610039, 5254.21186821976, 5259.710715910624, 5384.3807962084275, 5386.434424385442, 5392.325959255093, 5305.204219367107, 5308.124159513656, 5357.651752636066, 5374.892502149935, 5431.131019036935, 4440.955590444087, 5218.817341393033, 5343.091674415358, 5379.542738867201, 5392.56859451243, 4817.3737414136285, 4954.0, 5765.221695071195, 5995.2206213192, 6108.3280839107665, 5183.844484665466, 6248.0, 6249.625022498619, 6270.184875966095, 6270.529710271702, 6319.905201421982, 6339.239291285029, 6341.143945567382, 6341.8097457076365, 6368.140301059344, 6063.0, 6065.636061836304, 6073.696315184223, 6086.847828804227, 6097.69511524422, 5921.230240068763, 6032.276126864805, 6300.527460440485, 6349.555531112777, 6432.4532414744335, 6222.439980401695, 6271.184745982993, 6291.276503202191, 6306.716197771019, 6324.6521441321165, 6003.5797494174985, 6350.0, 6355.904661430082, 6378.585391949508, 6384.3934826191435, 6208.099825525273, 6214.906776398358, 6235.75056997715, 6274.843128921813, 6316.905246421307, 6229.065640154013, 6247.656378899204, 6262.655553944485, 6267.6866156692895, 6297.905531417033, 4295.78521073945, 4341.630961368319, 5104.081265372194, 5123.615728820353, 5130.204818253177, 4387.6270517006415, 4445.444319460067, 4455.487618923865, 4541.84103556374, 4547.3406356078185, 5944.138099975479, 6002.129691194752, 6040.637561746222, 6057.818265452043, 6101.786437474756, 6400.741652669342, 6430.164078669743, 6436.871262574816, 6437.485001199892, 6443.6455994920725, 5942.64344139353, 5998.760049597967, 6012.789552365646, 6019.819405417845, 6051.122587224828, 5661.631993920382, 5664.433556644302, 5665.716714164275, 5678.14827775837, 5690.886182276331, 6582.078509008743, 6607.57050791697, 6609.801705948829, 6614.768483103165, 6622.337766223339, 6179.6910154493, 6261.405166509175, 6300.338464461349, 6300.936990630035, 6377.840553986188, 6566.967165164144, 6586.275509693834, 6593.80218593443, 6598.1422415085735, 6599.373059559334, 6319.178506794087, 6324.494040476843, 6326.905096423649, 6329.019002054689, 6337.176167098248, 6202.038684003986, 6254.906176407449, 6271.310155882758, 6352.174217351715, 6440.033994900802, 4757.905681693299, 6137.478314343331, 6174.475169610454, 6269.62382257066, 6270.905936411049, 6253.78111766086, 6253.937460625336, 6277.340879207617, 6280.780172693934, 6294.8111556653375, 5885.47030767233, 5968.701564921824, 5969.701514924323, 6172.9074063889975, 6221.782237621662, 5678.233438485751, 6192.59748116389, 6250.9062364065485, 6263.561550691408, 6290.0, 6210.5652604319075, 6211.0, 6211.09939058843, 6218.253809542884, 6235.532335074797], "value": 5808.385587222436, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [465.2253997094837, 494.8490710333348, 500.9499050094991, 505.20430322242464, 591.8313280714997, 41196.79401602992, 43731.344029839536, 43992.78003609985, 44053.23787048518, 44163.55836441635, 45402.54597454025, 45912.0, 45959.08081838361, 46107.308390374084, 46212.306815397715, 9029.864552031724, 9267.119623635745, 9536.904630953706, 9748.95125524375, 9780.706578802612, 11711.238769479956, 12103.455344509519, 12138.211016283913, 12179.086568507353, 12303.446344914455, 12049.518019279261, 12070.215435996632, 12094.455749491293, 12105.27368357897, 12113.939430302837, 10111.494425278743, 12014.339211343373, 12021.699457513545, 12086.0, 12109.878901210963, 11867.52529898803, 11924.761504769942, 12024.51901923922, 12026.4588093536, 12038.939805301005, 39225.41161882574, 42379.15241695149, 43785.56214437847, 43835.561644383466, 43888.3416748749, 3504.474328850693, 3595.8381872815526, 4162.250794856925, 4182.958170418317, 4257.3613957906255, 29983.850080749675, 31658.0, 31669.52495712566, 32002.0, 34207.31585368279, 3352.1619595101224, 3512.1746389598425, 3512.209752805624, 3556.5732112146447, 3565.928681426383, 431132.5330120051, 498537.0, 505115.0, 508120.0, 509662.0, 68151.0, 68770.999999999, 68883.3111668877, 68982.65508672525, 69158.65420672965, 71917.0, 73807.63096184592, 73918.6304068487, 74064.25935740682, 74278.62860685663, 17872.463826085237, 18386.448406547825, 18695.15871785773, 18726.0, 18772.436826895217, 12780.808287875503, 13046.0, 13984.790228146587, 14047.157170569799, 14112.0, 20019.998000200154, 21608.78391216099, 22322.330330090124, 23153.421164470685, 23171.420714482272, 7594.848103037908, 8707.39048266628, 9223.308251881135, 9232.584533696, 9296.256299496024, 802.5345299726145, 854.2482615298497, 896.3456676626099, 901.6663834381321, 915.55342558757, 32234.791614018843, 32602.510962335586, 32666.673333266364, 32908.50637240443, 33158.502622460685, 1016.3343010328247, 1037.5123691864812, 1097.308695521832, 1160.6982184632056, 1222.4254600337827, 15666.843331566766, 16137.35450581987, 16686.33254669824, 16796.664066718597, 16806.915965420096, 656334.0, 658055.0, 659847.0, 663080.0, 666119.0, 58753.41246587565, 58836.0, 59439.70280148571, 59605.0, 59651.0, 1468.992655036718, 1483.7255107804874, 1491.6208647207902, 1510.5015344936144, 1520.186700115433, 29250.561241580966, 30764.538531922488, 30812.53781193329, 31135.065948021595, 31470.527942081346, 51503.71240719012, 51912.96174076573, 52024.73987630037, 52051.47948520466, 52099.739501302254, 603742.0, 606795.0, 608605.0, 608615.0, 609535.0, 24903.501929960938, 26252.474950500502, 27384.45231095327, 27615.447691045665, 28958.565621516114, 44580.55419445764, 45004.77497612491, 45448.54551454443, 45833.312500311855, 46079.0, 31321.84339078381, 31417.371652566362, 31632.367352653277, 32317.192070197492, 32647.673523264464, 32147.67852321447, 32333.0, 32710.34579308353, 32800.671993279764, 34683.82658086693, 37980.62019379771, 37986.8100659506, 38379.616203837606, 38597.6140238594, 38821.41767873541, 32724.345513089127, 33081.33837323192, 33393.0, 33744.65021399117, 34046.65953340534, 24456.0, 25797.871010644827, 26018.479630407666, 26107.608385873846, 26350.736492634827], "value": 21203.90533157586, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [324.8424514110656, 325.50848219189015, 393.48060560060725, 402.3642644621497, 430.56297857674446, 16172.676546469078, 21430.89284553579, 21623.783762162373, 21744.13023479061, 21996.780032199673, 17497.825021749777, 21809.90950452475, 22054.0, 22076.006579703913, 22530.211442599513, 4739.431268247798, 5512.503874651281, 5988.281406231247, 6165.876682466348, 6207.099970504274, 4437.64498840092, 4645.094206629708, 6039.094135879609, 6621.668916554153, 6885.414739747128, 6691.029800678899, 6925.826854328657, 6958.130233720785, 6973.163220413558, 6984.860302793941, 6657.201135863703, 6787.898181527281, 6793.218779840332, 6806.761763338284, 6810.182778066639, 4982.103221420143, 5833.679147646878, 5997.460228579449, 6001.909971350433, 6014.188084608566, 26080.217593472225, 26345.20964371072, 26385.3403664908, 26477.470450591074, 26999.32501687454, 2834.0222623194963, 2891.103757835078, 2911.839848808315, 2918.4017276458276, 2925.9853700731574, 13412.79880801779, 15548.144852033134, 16158.919205404016, 16229.59426014359, 16334.346626135059, 1573.402107199257, 1871.897045662488, 1879.6710575649342, 1890.931623632643, 1891.5838515526561, 130842.0, 132239.33880330538, 133927.66072339346, 135228.999999999, 135393.3230333842, 9806.460644664468, 11499.597514087134, 11740.765184696258, 11805.76388472243, 11843.170978031627, 12425.565105221274, 15009.849901501064, 15198.696026079417, 15211.239438028055, 15243.23783810805, 7391.81520461982, 8899.777505562413, 9052.728418147466, 9229.907700923039, 9273.165415112673, 7522.322990930843, 9045.140711632384, 9062.04848490912, 9149.451032938045, 9223.077692230858, 6643.40209381158, 7333.4866559340335, 7404.740834070782, 7436.996005539183, 7470.514416562906, 1704.3353092294014, 1793.103448275862, 1805.1786437171056, 1805.9187336569885, 1962.6957821537685, 868.1882439918696, 873.3580818098692, 881.457903389411, 883.2007033634571, 915.876356691838, 18602.81397186011, 20921.89539052295, 21059.578808423747, 21646.458838529164, 21951.67072493882, 897.8339007283673, 927.3786563002805, 947.5556352658, 954.3271993244746, 965.7875267441152, 9034.954825225963, 11147.21969462146, 11187.160962927814, 11438.714032149097, 11439.828402573969, 541083.0, 577136.0, 621362.0, 713691.0, 725383.0, 132770.0, 152056.47943520645, 152597.47402526054, 152628.23685881498, 159552.0, 858.5321000054985, 1001.5543083327995, 1004.3672486333563, 1019.0471908765476, 1027.5684212630713, 18155.36456224026, 19151.71272430887, 19156.808431915502, 19190.328338508087, 19233.0, 47224.0, 58870.82258354723, 60401.0, 61265.774684505166, 61823.0, 90114.09885901319, 90295.0, 91006.0, 92663.0, 92672.53663731639, 7495.400367970658, 7513.774586762406, 7802.141764406025, 7824.452288339761, 7969.402294827795, 12349.0, 12715.237085774514, 12841.0, 12947.5468358607, 13479.932600336935, 9645.565949532429, 11383.658490245305, 11492.310461372344, 11670.358130302575, 11831.230969986924, 10878.40168790724, 10946.233763636468, 10959.890401095887, 10969.341839489656, 11105.444727763741, 11659.358735269641, 11723.0, 11738.295702257892, 11778.293302401884, 12176.817347739614, 7310.305520975498, 7616.961915190389, 7644.961775191088, 8390.244877961013, 8773.912260877565, 8243.216894395024, 10076.496175191065, 11176.944115279697, 11396.943015285202, 11550.480228389575], "value": 10114.58877305326, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1343.8857697095746, 1439.4961763382823, 1487.5239923224565, 1488.7841263016862, 1501.2118637715198, 6685.565438246511, 7004.859902801941, 8220.465669731471, 8643.09247529009, 8665.956670216648, 6516.315786842384, 8270.007599088103, 8285.95857020714, 8372.0, 8376.62305196266, 2390.725066617335, 2412.384841865322, 2413.384586930339, 2421.055788242587, 2425.551273014498, 2403.567357875582, 2428.077330614364, 2434.1480481831395, 2438.6220135878966, 2439.329184474266, 2339.333290012347, 2361.0, 2367.3016460144213, 2385.2963375804093, 2396.760323967598, 2383.6305372667266, 2390.8087353011715, 2411.7347091819884, 2416.7704068113503, 2418.1294733895784, 2372.810175185981, 2381.7856392924546, 2397.4725560376687, 2413.891374888134, 2421.5641184586766, 8515.57422128891, 8579.399442039059, 8582.0, 8629.05080441151, 8640.827183456297, 5244.39689435716, 5366.758495867695, 5373.489518495776, 5398.082326004589, 5418.214358917974, 2970.3316753730455, 3546.184377593142, 3580.7493475456727, 3648.8358023888723, 3675.5221821163345, 1237.8205160251714, 1242.385019415386, 1267.9175853569582, 1293.5149319005372, 1294.0941341061296, 10955.397453140075, 11052.060574851066, 11052.281601695864, 11085.778284434266, 11127.443627818577, 4605.240880220218, 4704.082703872712, 4832.0, 4836.879078023077, 4876.463589005207, 9701.0, 9768.462734549668, 9782.51087445625, 9793.755156121155, 9804.754881127887, 5338.3060202173465, 5419.3225846769155, 5429.864253393618, 5453.182022696627, 5460.918086228709, 3737.9813100934866, 4116.506019277646, 4403.977980110143, 4957.082939656175, 4957.628177886673, 3996.0, 4022.939655905164, 4044.797760111983, 4077.408775727503, 4088.6729061674996, 1304.9086563940432, 1311.1739604049387, 1318.1432069155126, 1327.3761332174056, 1329.7739384304691, 923.4071227133142, 929.6002718830968, 944.9480278584743, 947.5262368815593, 975.7316737897135, 5618.073017951992, 5683.687397193112, 5846.795362162304, 5893.941060589425, 5995.820125396245, 556.5186114011351, 564.1256053117651, 571.1974675580816, 579.7246308003749, 584.3718003146635, 4027.0939038716056, 4100.323446631272, 4100.938485922714, 4114.567970363129, 4170.207660544487, 10066.245031622511, 10235.181185505291, 10244.64143754965, 10272.486375681186, 10281.4063820108, 10028.398296102258, 10152.441615711206, 10156.898431015743, 10226.386416815016, 10236.283460157867, 7568.243175682388, 7949.801254968556, 7958.0, 8050.919490805134, 8082.070561885458, 5742.339630942328, 5788.681622510802, 5812.622179558315, 5820.5925585210325, 5979.641221526722, 9400.764980875532, 9556.665516706882, 9564.234861210947, 9576.329656924227, 9603.663871764455, 9333.813323733351, 9482.620695172116, 9508.857367139637, 9591.42451452915, 9618.663346782829, 7280.0535930328715, 7426.443016773872, 7459.589722565094, 7513.586752728434, 7535.359494443033, 7950.562719050276, 8049.27556519916, 8053.436259462016, 8119.3098586618435, 8135.105138434886, 7131.429485641032, 7155.069840920647, 7165.749198778018, 7182.245864184394, 7280.781576552712, 6989.895151572832, 7060.823479413056, 7067.6819543119655, 7070.540414873017, 7097.609631470319, 5921.940780592139, 6481.384268494486, 6522.0, 6533.216014078341, 6600.339966003361, 4253.553376895381, 4971.9005619886675, 5077.644564880423, 5077.974610126926, 5100.923486147785, 5035.345405097314, 5099.87250318745, 5138.794448222029, 5179.48205179479, 5200.193969934666], "value": 4474.815841229503, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.4967750953494, 327.76892290934893, 342.2214462098725, 369.73861944529347, 385.7184255493488, 5219.530242278194, 5317.175837745146, 5466.590005749565, 5511.421300763423, 5529.668219906808, 4085.6293557814774, 4641.725554478307, 4945.703257804535, 5255.369355677314, 5429.715022411444, 3719.5350581177354, 4187.895302617436, 4247.893802654928, 4269.7404265741525, 4286.0, 4160.729552579088, 4169.541350451448, 4248.426462427564, 4280.764557949312, 4283.607827456073, 3643.9271214575692, 4188.371744238359, 4189.308764053927, 4202.915941681164, 4222.662187025031, 3533.628968958261, 4146.295129827937, 4206.663466922639, 4216.304309788881, 4253.659707223414, 3149.401613693391, 3743.4571987061995, 3757.9665591962157, 3778.5465744110606, 3780.584135745093, 4433.689641725081, 4871.318015477836, 5085.415177254626, 5196.0, 5350.625456218067, 4302.23608320587, 4889.828855990023, 4895.926561101586, 4915.156816193928, 4938.407391113089, 5208.671788693859, 5209.739513024371, 5218.190720773819, 5798.710064496759, 5803.459889467422, 3460.619331873492, 3657.085728567858, 3958.960410395888, 4083.428320035168, 4146.3365861462025, 5420.674759514442, 5441.830006548572, 5976.282846058457, 6123.489369358586, 6143.784967526115, 3635.2729454108753, 4189.392538081961, 4220.746755194698, 4239.0674051708575, 4244.72409293395, 3728.2357116790995, 3997.342431675043, 4038.394240863835, 4290.764007979591, 4294.3558466230315, 4168.395167860335, 4538.706468656417, 4730.692504987165, 4731.905361892743, 4777.498362671939, 5826.73779679907, 5874.441928016831, 5902.026165682614, 5943.0, 5958.553108516879, 1167.8832116788253, 1192.1224072086325, 1272.6500212441467, 1304.706441050756, 1308.3262120008203, 859.7893516088599, 882.8057827277988, 884.6417201033591, 888.7022847346083, 892.4734406700078, 4447.844325448594, 4683.157031734252, 4708.352076773171, 5163.554204822655, 5247.29764171452, 4870.707757534559, 5166.715830629276, 5652.756393593403, 5710.314762228559, 5773.336066352424, 4915.918497930521, 4985.850424487271, 5015.699058056528, 5099.582752454467, 5154.845354639367, 2309.711286089239, 2664.880080396387, 2675.224184986332, 2942.6174597302215, 3032.4086803073187, 5470.452954704498, 5869.530437564985, 5877.294724632986, 5931.487470695031, 5932.2584676915385, 4813.061453016629, 5703.233931543198, 5781.942180578225, 5914.290285165807, 5940.405959404112, 5554.805581804618, 6050.092486127028, 6203.4416902479, 6223.81328560153, 6241.8140553294725, 5683.914741278802, 6011.489023433057, 6013.278406591062, 6028.15605815195, 6041.69791510414, 4677.111348843709, 5149.665271757323, 5774.902768473977, 5860.326062502867, 5909.940900590939, 4992.951480189201, 5457.918131227955, 6144.631322120687, 6179.907301390393, 6256.874862502634, 3495.312445370159, 3758.6993040557236, 3807.2486656138485, 3831.7126215534504, 3978.661813745864, 5061.797528098835, 5514.724263786875, 5864.706764661664, 5925.614835035709, 5937.732802024006, 4909.759558691247, 5323.494268044529, 5724.570657200643, 5833.912491312549, 5848.941510584839, 4746.955669752787, 4910.582600479, 5813.970930145322, 5861.208736820475, 5863.355030946507, 5251.474852514871, 5397.973010134924, 5657.971710141587, 5694.373618901835, 5807.709614519342, 5760.971195144165, 5773.16289138081, 5819.5344372450945, 5831.475167234969, 5844.970775146097, 5005.674631148963, 5512.944870551243, 5712.228849105484, 5732.914006289992, 5734.254546908875], "value": 4176.049222115576, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [743.6467677853024, 750.4971668981782, 751.3500821789153, 793.8848866914298, 888.0675290944507, 13591.796123058137, 15160.696786064273, 15577.376904923789, 16310.918445407771, 16514.091724955153, 11930.761384772299, 14993.325300361483, 15029.774553381681, 15161.772573411408, 15181.848181518182, 887.0641473245723, 898.3980732908934, 919.7240827751681, 926.9768255793591, 928.3037721708719, 727.8617062758085, 916.3036092569662, 917.312015988009, 917.8072604752977, 920.2729843423688, 776.4564804636749, 778.696308439709, 932.3100905330041, 972.7179118055791, 978.4129522286606, 953.60902030168, 953.823542644613, 955.6082006377387, 958.9808203835919, 961.5721004153155, 698.8113209433425, 705.4180301251488, 706.533687766077, 710.6979533698158, 715.7459102018812, 11907.583234586835, 12741.554045608453, 15724.606884827856, 15869.20653967297, 15943.760843587355, 12478.688032799162, 14436.783448248285, 15077.958719002107, 15230.390784368612, 15379.307931143125, 11702.356370399624, 11888.881111188864, 11903.0, 11947.701307467296, 12002.219855709438, 3900.960990390088, 3903.882883513471, 3910.237503686754, 3939.113699417637, 3947.5460322063045, 82770.0, 103249.96750032478, 103839.48080259626, 105211.4739426298, 106699.46650266777, 11237.550497980154, 11374.601888933848, 11640.894115059056, 11807.645770626896, 11841.0, 24080.7591924082, 24282.271531854072, 24663.876680616482, 24678.383040423774, 25201.62197567038, 7912.248336408032, 8066.475679080841, 8108.067973131539, 8114.715984940499, 8162.306203972729, 4015.5984401560195, 4234.301340278881, 4470.396496472935, 4505.166544189336, 4580.88547786308, 3769.453429252743, 3845.5577608575372, 3852.1910398816003, 3855.7108216883844, 3870.0324918770307, 702.7470110760122, 704.1522234694303, 719.1765428584242, 729.3180875881068, 729.4201110117469, 698.849747304332, 725.6263024542365, 727.1020289941918, 727.4653129949482, 739.7041183526525, 10370.688879333633, 10634.521446534924, 10924.2899211551, 11040.503177357039, 11167.664970050912, 696.8153439338579, 719.7516856684435, 735.5623404074568, 750.3097150621442, 750.5459197185625, 4626.421697287839, 5118.3090282811345, 5129.820456284012, 5132.204508301219, 5140.280360749498, 90510.0, 99842.0, 100184.0, 100477.0, 105920.94079059265, 78937.0, 79305.20694793094, 81748.59125704333, 87781.0, 90301.0, 61984.76030479365, 70065.64967175132, 73722.63138684272, 76459.0, 76843.61578192073, 9921.900780992097, 9924.553395097093, 10019.949900250453, 10022.899771002196, 10056.497175141067, 32125.678743213204, 51866.0, 52224.738876305375, 52324.21513677222, 53315.0, 65100.348996511326, 66751.0, 67629.9855502158, 70522.29477705363, 70546.29453705397, 13180.80228796588, 13368.264745439094, 13416.329183540589, 13860.029797914049, 13990.230537320545, 14712.264386780833, 15025.137848716637, 15260.847391525942, 15288.617784555476, 15320.157391343137, 13781.793273100711, 13911.652208694864, 13965.441382345, 14220.928895355457, 14411.207383594003, 14039.789403159166, 14068.507602233873, 14261.0, 14294.142351458946, 14873.776893346392, 13616.795748063985, 14122.50571230002, 14127.505537306144, 14167.574972750834, 14193.574192774233, 9350.392224505385, 9733.124018838338, 9860.26048046385, 9921.801563968536, 9940.304178707422, 9748.805023899624, 11262.774744505228, 11371.54513819438, 11567.132465064986, 11790.94104529472], "value": 7700.681831688677, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1543.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 118.0, 119.0, 118.0, 117.0, 117.0, 117.0, 116.0, 118.0, 119.0], "value": 116.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 107.0, 141.0, 183.0, 141.0, 110.0, 111.0, 107.0, 129.0, 112.0], "value": 128.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 204.0, 194.0, 233.0, 223.0, 197.0, 199.0, 198.0, 217.0, 177.0], "value": 203.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 61.0, 59.0, 93.0, 79.0, 52.0, 50.0, 60.0, 83.0, 84.0], "value": 69.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 71.0, 85.0, 74.0, 69.0, 70.0, 78.0, 71.0, 75.0, 102.0], "value": 77.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 131.0, 88.0, 86.0, 89.0, 86.0, 90.0, 107.0, 89.0, 86.0], "value": 95.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 102.0, 96.0, 126.0, 99.0, 142.0, 155.0, 107.0, 95.0, 95.0], "value": 111.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 104.0, 113.0, 129.0, 147.0, 114.0, 94.0, 93.0, 103.0, 77.0], "value": 111.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 61.0, 58.0, 61.0, 63.0, 61.0, 62.0, 62.0, 61.0, 62.0], "value": 60.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 72.0, 69.0, 83.0, 79.0, 76.0, 68.0, 71.0, 74.0, 87.0], "value": 75.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 82.0, 85.0, 83.0, 81.0, 82.0, 82.0, 90.0, 83.0, 82.0], "value": 83.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 150.0, 149.0, 160.0, 153.0, 130.0, 138.0, 140.0, 210.0, 171.0], "value": 153.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 188.0, 166.0, 165.0, 183.0, 226.0, 210.0, 166.0, 163.0, 165.0], "value": 179.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 66.0, 70.0, 89.0, 95.0, 57.0, 76.0, 85.0, 91.0], "value": 76.1, "unit": "score"}]}]} 14:26:25 INFO - Return code: 0 14:26:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:26:25 ERROR - # TBPL SUCCESS # 14:26:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:26:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:26:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:26:25 INFO - 2017-03-30 14:26:25.822 screenresolution[2536:35379] starting screenresolution argv=screenresolution get 14:26:25 INFO - 2017-03-30 14:26:25.824 screenresolution[2536:35379] Display 0: 1600x1200x32@60 14:26:25 INFO - 2017-03-30 14:26:25.830 screenresolution[2537:35382] starting screenresolution argv=screenresolution list 14:26:25 INFO - Available Modes on Display 0 14:26:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:26:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:26:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:26:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:26:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:26:26 INFO - Intel Iris: 14:26:26 INFO - Chipset Model: Intel Iris 14:26:26 INFO - Type: GPU 14:26:26 INFO - Bus: Built-In 14:26:26 INFO - VRAM (Dynamic, Max): 1536 MB 14:26:26 INFO - Vendor: Intel (0x8086) 14:26:26 INFO - Device ID: 0x0a2e 14:26:26 INFO - Revision ID: 0x0009 14:26:26 INFO - Displays: 14:26:26 INFO - Display: 14:26:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:26:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:26:26 INFO - Display Serial Number: 1600x1200 60 14:26:26 INFO - Main Display: Yes 14:26:26 INFO - Mirror: Off 14:26:26 INFO - Online: Yes 14:26:26 INFO - Rotation: Supported 14:26:26 INFO - Return code: 0 14:26:26 INFO - Running post-action listener: _resource_record_post_action 14:26:26 INFO - [mozharness: 2017-03-30 21:26:26.070460Z] Finished run-tests step (success) 14:26:26 INFO - Running post-run listener: _resource_record_post_run 14:26:26 INFO - Total resource usage - Wall time: 1190s; CPU: 54.0%; Read bytes: 946176; Write bytes: 424881664; Read time: 8; Write time: 1427 14:26:26 INFO - TinderboxPrint: CPU usage
54.3% 14:26:26 INFO - TinderboxPrint: I/O read bytes / time
946,176 / 8 14:26:26 INFO - TinderboxPrint: I/O write bytes / time
424,881,664 / 1,427 14:26:26 INFO - TinderboxPrint: CPU idle
2,177.6 (45.7%) 14:26:26 INFO - TinderboxPrint: CPU system
962.6 (20.2%) 14:26:26 INFO - TinderboxPrint: CPU user
1,621.5 (34.1%) 14:26:26 INFO - TinderboxPrint: Swap in / out
122,028,032 / 0 14:26:26 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 122575360; Write bytes: 123693056; Read time: 11106; Write time: 275 14:26:26 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 827392; Write bytes: 299804160; Read time: 6; Write time: 1143 14:26:26 INFO - Running post-run listener: _upload_blobber_files 14:26:26 INFO - Blob upload gear active. 14:26:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:26:26 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:26:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:26:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:26:26 INFO - (blobuploader) - INFO - Open directory for files ... 14:26:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:26:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:26:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:26:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:26:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:26:27 INFO - (blobuploader) - INFO - Done attempting. 14:26:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:26:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:26:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:26:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:26:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:26:28 INFO - (blobuploader) - INFO - Done attempting. 14:26:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 14:26:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:26:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:26:29 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 14:26:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:26:29 INFO - (blobuploader) - INFO - Done attempting. 14:26:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:26:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:26:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:26:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:26:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:26:31 INFO - (blobuploader) - INFO - Done attempting. 14:26:31 INFO - (blobuploader) - INFO - Iteration through files over. 14:26:31 INFO - Return code: 0 14:26:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:26:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:26:31 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0888ae650faf326ab3d2130f274edbfa067794b569baf09ec694ad84299d0f198b26344af62581ad02d0d98863fc12157c9134dd34eeef9f69106bedbb6a28f9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ccf49bc5fd9565d2d3f0869a8daac61298b48ed83e2b415d1c9ac96c2f2051c3d1211accf1a2859822f07b1d63b5263d0230bb8f5ac9d9a35c1af882e804ee8a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/607b84448d36d6b2b03133c137e32c7be8f5c9d8e9fc699d3cd47d82b243a49c516e37489da6374c943fcb557b9f42a9d75bb85f944cd2075815cbf63a4dd70b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d7e8a7d9d4aecff760eda27f249cde6721ed77919b100fb7aa08c60320670e7d2f4982253b509013370842e1c03d338bc0cd3f2987bf007f472113e1084d9b38"} 14:26:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:26:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:26:31 INFO - Contents: 14:26:31 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0888ae650faf326ab3d2130f274edbfa067794b569baf09ec694ad84299d0f198b26344af62581ad02d0d98863fc12157c9134dd34eeef9f69106bedbb6a28f9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ccf49bc5fd9565d2d3f0869a8daac61298b48ed83e2b415d1c9ac96c2f2051c3d1211accf1a2859822f07b1d63b5263d0230bb8f5ac9d9a35c1af882e804ee8a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/607b84448d36d6b2b03133c137e32c7be8f5c9d8e9fc699d3cd47d82b243a49c516e37489da6374c943fcb557b9f42a9d75bb85f944cd2075815cbf63a4dd70b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d7e8a7d9d4aecff760eda27f249cde6721ed77919b100fb7aa08c60320670e7d2f4982253b509013370842e1c03d338bc0cd3f2987bf007f472113e1084d9b38"} 14:26:31 INFO - Running post-run listener: copy_logs_to_upload_dir 14:26:31 INFO - Copying logs to upload dir... 14:26:31 INFO - mkdir: /builds/slave/test/build/upload/logs 14:26:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.057923 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-03-30 14:26:31.657510) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-30 14:26:31.660787) ========= 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.KoyyRUu6cI/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.iCaWgT6dWO/Listeners TMPDIR=/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0888ae650faf326ab3d2130f274edbfa067794b569baf09ec694ad84299d0f198b26344af62581ad02d0d98863fc12157c9134dd34eeef9f69106bedbb6a28f9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ccf49bc5fd9565d2d3f0869a8daac61298b48ed83e2b415d1c9ac96c2f2051c3d1211accf1a2859822f07b1d63b5263d0230bb8f5ac9d9a35c1af882e804ee8a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/607b84448d36d6b2b03133c137e32c7be8f5c9d8e9fc699d3cd47d82b243a49c516e37489da6374c943fcb557b9f42a9d75bb85f944cd2075815cbf63a4dd70b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d7e8a7d9d4aecff760eda27f249cde6721ed77919b100fb7aa08c60320670e7d2f4982253b509013370842e1c03d338bc0cd3f2987bf007f472113e1084d9b38"} build_url:https://queue.taskcluster.net/v1/task/MGXW8r5bSNu7I7p_gcE95g/artifacts/public/build/firefox-53.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011391 build_url: 'https://queue.taskcluster.net/v1/task/MGXW8r5bSNu7I7p_gcE95g/artifacts/public/build/firefox-53.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0888ae650faf326ab3d2130f274edbfa067794b569baf09ec694ad84299d0f198b26344af62581ad02d0d98863fc12157c9134dd34eeef9f69106bedbb6a28f9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ccf49bc5fd9565d2d3f0869a8daac61298b48ed83e2b415d1c9ac96c2f2051c3d1211accf1a2859822f07b1d63b5263d0230bb8f5ac9d9a35c1af882e804ee8a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/607b84448d36d6b2b03133c137e32c7be8f5c9d8e9fc699d3cd47d82b243a49c516e37489da6374c943fcb557b9f42a9d75bb85f944cd2075815cbf63a4dd70b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d7e8a7d9d4aecff760eda27f249cde6721ed77919b100fb7aa08c60320670e7d2f4982253b509013370842e1c03d338bc0cd3f2987bf007f472113e1084d9b38"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-30 14:26:31.700212) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 14:26:31.701018) ========= 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.KoyyRUu6cI/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.iCaWgT6dWO/Listeners TMPDIR=/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/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.005374 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 14:26:31.753190) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-30 14:26:31.753967) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-30 14:26:31.754699) ========= ========= Total master_lag: 0.20 =========