builder: graphics_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0351 starttime: 1484751910.23 results: success (0) buildid: 20170118050726 builduid: df04d57f2cf54ee894856e3245d52267 revision: 8fcc95d1411532306d08b49471214e0f0fcd7a8c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-18 07:05:10.227513) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-18 07:05:10.228368) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 8 secs) (at 2017-01-18 07:05:10.228820) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 8 secs) (at 2017-01-18 07:05:18.801037) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-18 07:05:18.801506) ========= 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.SSZtr2Gfs5/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.iOpxd0UoZA/Listeners TMPDIR=/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/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-01-18 07:05:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 164M=0s 2017-01-18 07:05:20 (164 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=1.211539 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-18 07:05:20.044847) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 07:05:20.045237) ========= 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.SSZtr2Gfs5/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.iOpxd0UoZA/Listeners TMPDIR=/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/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.019643 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 07:05:20.096263) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-18 07:05:20.096779) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev 8fcc95d1411532306d08b49471214e0f0fcd7a8c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/graphics --rev 8fcc95d1411532306d08b49471214e0f0fcd7a8c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.SSZtr2Gfs5/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.iOpxd0UoZA/Listeners TMPDIR=/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/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-01-18 07:05:20,182 truncating revision to first 12 chars 2017-01-18 07:05:20,182 Setting DEBUG logging. 2017-01-18 07:05:20,182 attempt 1/10 2017-01-18 07:05:20,182 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/8fcc95d14115?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-18 07:05:21,596 unpacking tar archive at: graphics-8fcc95d14115/testing/mozharness/ program finished with exit code 0 elapsedTime=1.658512 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-18 07:05:21.782920) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-18 07:05:21.783354) ========= script_repo_revision: 8fcc95d1411532306d08b49471214e0f0fcd7a8c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-18 07:05:21.783759) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-18 07:05:21.784166) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-18 07:05:21.807585) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2017-01-18 07:05:21.808227) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Graphics --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 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', 'Graphics', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Graphics'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.SSZtr2Gfs5/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.iOpxd0UoZA/Listeners TMPDIR=/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/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 07:05:22 INFO - MultiFileLogger online at 20170118 07:05:22 in /builds/slave/test 07:05:22 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Graphics --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 07:05:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:05:22 INFO - {'append_to_log': False, 07:05:22 INFO - 'base_work_dir': '/builds/slave/test', 07:05:22 INFO - 'blob_upload_branch': 'Graphics', 07:05:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:05:22 INFO - 'branch': 'Graphics', 07:05:22 INFO - 'buildbot_json_path': 'buildprops.json', 07:05:22 INFO - 'config_files': ('talos/mac_config.py',), 07:05:22 INFO - 'default_actions': ('clobber', 07:05:22 INFO - 'read-buildbot-config', 07:05:22 INFO - 'download-and-extract', 07:05:22 INFO - 'populate-webroot', 07:05:22 INFO - 'create-virtualenv', 07:05:22 INFO - 'install', 07:05:22 INFO - 'run-tests'), 07:05:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:05:22 INFO - 'download_minidump_stackwalk': True, 07:05:22 INFO - 'download_symbols': 'ondemand', 07:05:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:05:22 INFO - 'tooltool.py': '/tools/tooltool.py', 07:05:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:05:22 INFO - '/tools/misc-python/virtualenv.py')}, 07:05:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:05:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:05:22 INFO - 'installer_path': 'installer.exe', 07:05:22 INFO - 'log_level': 'info', 07:05:22 INFO - 'log_name': 'talos', 07:05:22 INFO - 'log_to_console': True, 07:05:22 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:05:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:05:22 INFO - 'opt_config_files': (), 07:05:22 INFO - 'pip_index': False, 07:05:22 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:05:22 INFO - 'cmd': ('bash', 07:05:22 INFO - '-c', 07:05:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:05:22 INFO - 'enabled': True, 07:05:22 INFO - 'halt_on_failure': False, 07:05:22 INFO - 'name': 'check_screen_resolution'},), 07:05:22 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:05:22 INFO - 'cmd': ('bash', 07:05:22 INFO - '-c', 07:05:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:05:22 INFO - 'enabled': True, 07:05:22 INFO - 'halt_on_failure': False, 07:05:22 INFO - 'name': 'check_screen_resolution'},), 07:05:22 INFO - 'run_cmd_checks_enabled': True, 07:05:22 INFO - 'sps_profile': False, 07:05:22 INFO - 'sps_profile_interval': 0, 07:05:22 INFO - 'suite': 'dromaeojs-e10s', 07:05:22 INFO - 'system_bits': '32', 07:05:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:05:22 INFO - 'title': 't-yosemite-r7-0351', 07:05:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:05:22 INFO - 'use_talos_json': True, 07:05:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:05:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:05:22 INFO - 'work_dir': 'build'} 07:05:22 INFO - [mozharness: 2017-01-18 15:05:22.012831Z] Running clobber step. 07:05:22 INFO - Running pre-action listener: _resource_record_pre_action 07:05:22 INFO - Running main action method: clobber 07:05:22 INFO - rmtree: /builds/slave/test/build 07:05:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:05:22 INFO - Running post-action listener: _resource_record_post_action 07:05:22 INFO - [mozharness: 2017-01-18 15:05:22.952624Z] Finished clobber step (success) 07:05:22 INFO - [mozharness: 2017-01-18 15:05:22.952816Z] Running read-buildbot-config step. 07:05:22 INFO - Running pre-action listener: _resource_record_pre_action 07:05:22 INFO - Running main action method: read_buildbot_config 07:05:22 INFO - Using buildbot properties: 07:05:22 INFO - { 07:05:22 INFO - "project": "", 07:05:22 INFO - "product": "firefox", 07:05:22 INFO - "script_repo_revision": "default", 07:05:22 INFO - "builddir": "graphics_yosemite_r7_test-dromaeojs-e10s", 07:05:22 INFO - "repository": "", 07:05:22 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 graphics talos dromaeojs-e10s", 07:05:22 INFO - "buildid": "20170118050726", 07:05:22 INFO - "pgo_build": "False", 07:05:22 INFO - "basedir": "/builds/slave/test", 07:05:22 INFO - "buildnumber": 12, 07:05:22 INFO - "slavename": "t-yosemite-r7-0351", 07:05:22 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 07:05:22 INFO - "platform": "yosemite_r7", 07:05:22 INFO - "scheduler": "tests-graphics-macosx64-talos-8-3600", 07:05:22 INFO - "branch": "graphics", 07:05:22 INFO - "repo_path": "projects/graphics", 07:05:22 INFO - "revision": "8fcc95d1411532306d08b49471214e0f0fcd7a8c", 07:05:22 INFO - "stage_platform": "macosx64", 07:05:22 INFO - "builduid": "df04d57f2cf54ee894856e3245d52267", 07:05:22 INFO - "slavebuilddir": "test" 07:05:22 INFO - } 07:05:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/HaHq5S69Roi59vRIAd8-PA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 07:05:22 INFO - Running post-action listener: _resource_record_post_action 07:05:22 INFO - [mozharness: 2017-01-18 15:05:22.958244Z] Finished read-buildbot-config step (success) 07:05:22 INFO - [mozharness: 2017-01-18 15:05:22.958441Z] Running download-and-extract step. 07:05:22 INFO - Running pre-action listener: _resource_record_pre_action 07:05:22 INFO - Running main action method: download_and_extract 07:05:22 INFO - mkdir: /builds/slave/test/build/tests 07:05:22 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')]} 07:05:22 INFO - trying https://queue.taskcluster.net/v1/task/HaHq5S69Roi59vRIAd8-PA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 07:05:22 INFO - Downloading https://queue.taskcluster.net/v1/task/HaHq5S69Roi59vRIAd8-PA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 07:05:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HaHq5S69Roi59vRIAd8-PA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 07:05:25 INFO - Downloaded 1199 bytes. 07:05:25 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 07:05:25 INFO - Using the following test package requirements: 07:05:25 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 07:05:25 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:05:25 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 07:05:25 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:05:25 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 07:05:25 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:05:25 INFO - u'jsshell-mac.zip'], 07:05:25 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:05:25 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 07:05:25 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 07:05:25 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:05:25 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 07:05:25 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:05:25 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 07:05:25 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:05:25 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 07:05:25 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:05:25 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 07:05:25 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 07:05:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HaHq5S69Roi59vRIAd8-PA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 07:05:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HaHq5S69Roi59vRIAd8-PA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:05:25 INFO - Fetch https://queue.taskcluster.net/v1/task/HaHq5S69Roi59vRIAd8-PA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 07:05:26 INFO - Expected file size: 16326547 07:05:26 INFO - Obtained file size: 16326547 07:05:33 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 07:05:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HaHq5S69Roi59vRIAd8-PA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 07:05:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HaHq5S69Roi59vRIAd8-PA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:05:33 INFO - Fetch https://queue.taskcluster.net/v1/task/HaHq5S69Roi59vRIAd8-PA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 07:05:34 INFO - Expected file size: 16326547 07:05:34 INFO - Obtained file size: 16326547 07:05:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HaHq5S69Roi59vRIAd8-PA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 07:05:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HaHq5S69Roi59vRIAd8-PA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 07:05:40 INFO - Fetch https://queue.taskcluster.net/v1/task/HaHq5S69Roi59vRIAd8-PA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 07:05:49 INFO - Expected file size: 14403463 07:05:49 INFO - Obtained file size: 14403463 07:05: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')]} 07:05:50 INFO - trying https://queue.taskcluster.net/v1/task/HaHq5S69Roi59vRIAd8-PA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 07:05:50 INFO - Downloading https://queue.taskcluster.net/v1/task/HaHq5S69Roi59vRIAd8-PA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 07:05:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HaHq5S69Roi59vRIAd8-PA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 07:05:53 INFO - Downloaded 70310782 bytes. 07:05:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HaHq5S69Roi59vRIAd8-PA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 07:05:53 INFO - mkdir: /builds/slave/test/properties 07:05:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:05:53 INFO - Writing to file /builds/slave/test/properties/build_url 07:05:53 INFO - Contents: 07:05:53 INFO - build_url:https://queue.taskcluster.net/v1/task/HaHq5S69Roi59vRIAd8-PA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 07:05:54 INFO - Running post-action listener: _resource_record_post_action 07:05:54 INFO - Running post-action listener: set_extra_try_arguments 07:05:54 INFO - [mozharness: 2017-01-18 15:05:54.148517Z] Finished download-and-extract step (success) 07:05:54 INFO - [mozharness: 2017-01-18 15:05:54.148638Z] Running populate-webroot step. 07:05:54 INFO - Running pre-action listener: _resource_record_pre_action 07:05:54 INFO - Running main action method: populate_webroot 07:05:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:05:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:05:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:05:54 INFO - '--tppagecycles', 07:05:54 INFO - '7'], 07:05:54 INFO - 'tests': ['tsvgm']}}, 07:05:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:05:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:05:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:05:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:05:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:05:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:05:54 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:05:54 INFO - 'talos_options': ['--disable-e10s'], 07:05:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:05:54 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:05:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:05:54 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:05:54 INFO - 'talos_options': ['--disable-e10s'], 07:05:54 INFO - 'tests': ['damp', 'tps']}, 07:05:54 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:05:54 INFO - 'tests': ['damp', 'tps']}, 07:05:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:05:54 INFO - 'tests': ['dromaeo_dom']}, 07:05:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:05:54 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:05:54 INFO - 'tests': ['basic_compositor_video']}, 07:05:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:05:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:05:54 INFO - 'tests': ['a11yr', 07:05:54 INFO - 'ts_paint', 07:05:54 INFO - 'tpaint', 07:05:54 INFO - 'sessionrestore', 07:05:54 INFO - 'sessionrestore_no_auto_restore', 07:05:54 INFO - 'tabpaint']}, 07:05:54 INFO - 'other-e10s': {'tests': ['a11yr', 07:05:54 INFO - 'ts_paint', 07:05:54 INFO - 'tpaint', 07:05:54 INFO - 'sessionrestore', 07:05:54 INFO - 'sessionrestore_no_auto_restore', 07:05:54 INFO - 'tabpaint']}, 07:05:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:05:54 INFO - 'ts_paint', 07:05:54 INFO - 'tpaint', 07:05:54 INFO - 'sessionrestore', 07:05:54 INFO - 'sessionrestore_no_auto_restore', 07:05:54 INFO - 'tabpaint']}, 07:05:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:05:54 INFO - 'ts_paint', 07:05:54 INFO - 'tpaint', 07:05:54 INFO - 'sessionrestore', 07:05:54 INFO - 'sessionrestore_no_auto_restore', 07:05:54 INFO - 'tabpaint']}, 07:05:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:05:54 INFO - 'tests': ['a11yr', 07:05:54 INFO - 'ts_paint', 07:05:54 INFO - 'tpaint', 07:05:54 INFO - 'sessionrestore', 07:05:54 INFO - 'sessionrestore_no_auto_restore', 07:05:54 INFO - 'tabpaint']}, 07:05:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:05:54 INFO - 'tests': ['a11yr', 07:05:54 INFO - 'ts_paint', 07:05:54 INFO - 'tpaint', 07:05:54 INFO - 'sessionrestore', 07:05:54 INFO - 'sessionrestore_no_auto_restore', 07:05:54 INFO - 'tabpaint']}, 07:05:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:05:54 INFO - 'tests': ['tsvgx', 07:05:54 INFO - 'tsvgr_opacity', 07:05:54 INFO - 'tart', 07:05:54 INFO - 'tscrollx', 07:05:54 INFO - 'cart', 07:05:54 INFO - 'tsvg_static']}, 07:05:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:05:54 INFO - 'tsvgr_opacity', 07:05:54 INFO - 'tart', 07:05:54 INFO - 'tscrollx', 07:05:54 INFO - 'cart', 07:05:54 INFO - 'tsvg_static']}, 07:05:54 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:05:54 INFO - 'talos_options': ['--disable-e10s'], 07:05:54 INFO - 'tests': ['tp5o']}, 07:05:54 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:05:54 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:05:54 INFO - 'talos_options': ['--disable-e10s', 07:05:54 INFO - '--xperf_path', 07:05:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:05:54 INFO - 'tests': ['tp5n']}, 07:05:54 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:05:54 INFO - 'talos_options': ['--xperf_path', 07:05:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:05:54 INFO - 'tests': ['tp5n']}}, 07:05:54 INFO - 'talos.zip': {'path': '', 07:05:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:05:54 INFO - Running post-action listener: _resource_record_post_action 07:05:54 INFO - [mozharness: 2017-01-18 15:05:54.167498Z] Finished populate-webroot step (success) 07:05:54 INFO - [mozharness: 2017-01-18 15:05:54.167617Z] Running create-virtualenv step. 07:05:54 INFO - Running pre-action listener: _resource_record_pre_action 07:05:54 INFO - Running main action method: create_virtualenv 07:05:54 INFO - Creating virtualenv /builds/slave/test/build/venv 07:05:54 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:05:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:05:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:05:54 INFO - Using real prefix '/tools/python27' 07:05:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:05:54 INFO - Installing distribute.............................................................................................................................................................................................done. 07:05:57 INFO - Installing pip.................done. 07:05:57 INFO - Return code: 0 07:05:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:05:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:05:58 INFO - Reading from file tmpfile_stdout 07:05:58 INFO - Output received: 07:05:58 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) 07:05:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:05:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:05:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:05:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:05:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:05:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:59 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 0x1021d5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021d8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98a1486040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101fb3d30>, '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 0x101edadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101fa8be8>, '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.SSZtr2Gfs5/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.iOpxd0UoZA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/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 07:05:59 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 07:05:59 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 07:05:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SSZtr2Gfs5/Render', 07:05:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:05:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:05:59 INFO - 'HOME': '/Users/cltbld', 07:05:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:05:59 INFO - 'LOGNAME': 'cltbld', 07:05:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:05:59 INFO - 'MOZ_NO_REMOTE': '1', 07:05:59 INFO - 'NO_EM_RESTART': '1', 07:05:59 INFO - 'PAGER': '/bin/cat', 07:05:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:05:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:05:59 INFO - 'PWD': '/builds/slave/test', 07:05:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:05:59 INFO - 'SHELL': '/bin/bash', 07:05:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iOpxd0UoZA/Listeners', 07:05:59 INFO - 'TMPDIR': '/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/', 07:05:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:05:59 INFO - 'USER': 'cltbld', 07:05:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:05:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:05:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:05:59 INFO - 'XPC_FLAGS': '0x0', 07:05:59 INFO - 'XPC_SERVICE_NAME': '0', 07:05:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:06:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:00 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 07:06:00 INFO - Cleaning up... 07:06:00 INFO - Return code: 0 07:06:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:06:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1021d5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021d8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98a1486040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101fb3d30>, '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 0x101edadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101fa8be8>, '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.SSZtr2Gfs5/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.iOpxd0UoZA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/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 07:06:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:06:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:06:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SSZtr2Gfs5/Render', 07:06:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:06:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:06:00 INFO - 'HOME': '/Users/cltbld', 07:06:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:06:00 INFO - 'LOGNAME': 'cltbld', 07:06:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:00 INFO - 'MOZ_NO_REMOTE': '1', 07:06:00 INFO - 'NO_EM_RESTART': '1', 07:06:00 INFO - 'PAGER': '/bin/cat', 07:06:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:06:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:00 INFO - 'PWD': '/builds/slave/test', 07:06:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:06:00 INFO - 'SHELL': '/bin/bash', 07:06:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iOpxd0UoZA/Listeners', 07:06:00 INFO - 'TMPDIR': '/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/', 07:06:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:06:00 INFO - 'USER': 'cltbld', 07:06:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:06:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:06:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:00 INFO - 'XPC_FLAGS': '0x0', 07:06:00 INFO - 'XPC_SERVICE_NAME': '0', 07:06:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:06:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:00 INFO - Downloading/unpacking psutil>=3.1.1 07:06:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:06:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:06:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:06:07 INFO - Installing collected packages: psutil 07:06:07 INFO - Running setup.py install for psutil 07:06:07 INFO - building 'psutil._psutil_osx' extension 07:06:07 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 07:06:07 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 07:06:07 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 07:06:07 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 07:06:07 INFO - building 'psutil._psutil_posix' extension 07:06:07 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 07:06:07 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:06:07 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:06:07 INFO - ^ 07:06:07 INFO - 1 warning generated. 07:06:07 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 07:06:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:06:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:06:07 INFO - Successfully installed psutil 07:06:07 INFO - Cleaning up... 07:06:07 INFO - Return code: 0 07:06:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:06:07 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')]} 07:06:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1021d5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021d8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98a1486040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101fb3d30>, '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 0x101edadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101fa8be8>, '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.SSZtr2Gfs5/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.iOpxd0UoZA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/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 07:06:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:06:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:06:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SSZtr2Gfs5/Render', 07:06:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:06:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:06:08 INFO - 'HOME': '/Users/cltbld', 07:06:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:06:08 INFO - 'LOGNAME': 'cltbld', 07:06:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:08 INFO - 'MOZ_NO_REMOTE': '1', 07:06:08 INFO - 'NO_EM_RESTART': '1', 07:06:08 INFO - 'PAGER': '/bin/cat', 07:06:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:06:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:08 INFO - 'PWD': '/builds/slave/test', 07:06:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:06:08 INFO - 'SHELL': '/bin/bash', 07:06:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iOpxd0UoZA/Listeners', 07:06:08 INFO - 'TMPDIR': '/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/', 07:06:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:06:08 INFO - 'USER': 'cltbld', 07:06:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:06:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:06:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:08 INFO - 'XPC_FLAGS': '0x0', 07:06:08 INFO - 'XPC_SERVICE_NAME': '0', 07:06:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:06:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:06:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:06:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:06:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:06:11 INFO - Installing collected packages: mozsystemmonitor 07:06:11 INFO - Running setup.py install for mozsystemmonitor 07:06:11 INFO - Successfully installed mozsystemmonitor 07:06:11 INFO - Cleaning up... 07:06:11 INFO - Return code: 0 07:06:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07: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')]} 07:06:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07: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')]} 07:06:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07: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', '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 0x1021d5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021d8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98a1486040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101fb3d30>, '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 0x101edadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101fa8be8>, '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.SSZtr2Gfs5/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.iOpxd0UoZA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/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 07: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 07: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 jsonschema==2.5.1 07:06:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SSZtr2Gfs5/Render', 07:06:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:06:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:06:11 INFO - 'HOME': '/Users/cltbld', 07:06:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:06:11 INFO - 'LOGNAME': 'cltbld', 07:06:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:11 INFO - 'MOZ_NO_REMOTE': '1', 07:06:11 INFO - 'NO_EM_RESTART': '1', 07:06:11 INFO - 'PAGER': '/bin/cat', 07:06:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:06:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:11 INFO - 'PWD': '/builds/slave/test', 07:06:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:06:11 INFO - 'SHELL': '/bin/bash', 07:06:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iOpxd0UoZA/Listeners', 07:06:11 INFO - 'TMPDIR': '/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/', 07:06:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:06:11 INFO - 'USER': 'cltbld', 07:06:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:06:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:06:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:11 INFO - 'XPC_FLAGS': '0x0', 07:06:11 INFO - 'XPC_SERVICE_NAME': '0', 07:06:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:06:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:12 INFO - Downloading/unpacking jsonschema==2.5.1 07:06:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:06:15 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:06:15 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 07:06:15 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 07:06:15 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 07:06:15 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 07:06:15 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 07:06:15 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 07:06:15 INFO - Downloading functools32-3.2.3-2.tar.gz 07:06:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:06:15 INFO - warning: no files found matching '*.txt' 07:06:15 INFO - no previously-included directories found matching 'build' 07:06:15 INFO - no previously-included directories found matching 'dist' 07:06:15 INFO - no previously-included directories found matching '.git*' 07:06:15 INFO - Installing collected packages: jsonschema, functools32 07:06:15 INFO - Running setup.py install for functools32 07:06:15 INFO - warning: no files found matching '*.txt' 07:06:15 INFO - no previously-included directories found matching 'build' 07:06:15 INFO - no previously-included directories found matching 'dist' 07:06:15 INFO - no previously-included directories found matching '.git*' 07:06:15 INFO - Successfully installed jsonschema functools32 07:06:15 INFO - Cleaning up... 07:06:15 INFO - Return code: 0 07:06:15 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:06:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:15 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 0x1021d5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021d8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98a1486040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101fb3d30>, '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 0x101edadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101fa8be8>, '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.SSZtr2Gfs5/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.iOpxd0UoZA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/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 07:06:15 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 07:06:15 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 07:06:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SSZtr2Gfs5/Render', 07:06:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:06:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:06:15 INFO - 'HOME': '/Users/cltbld', 07:06:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:06:15 INFO - 'LOGNAME': 'cltbld', 07:06:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:15 INFO - 'MOZ_NO_REMOTE': '1', 07:06:15 INFO - 'NO_EM_RESTART': '1', 07:06:15 INFO - 'PAGER': '/bin/cat', 07:06:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:06:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:15 INFO - 'PWD': '/builds/slave/test', 07:06:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:06:15 INFO - 'SHELL': '/bin/bash', 07:06:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iOpxd0UoZA/Listeners', 07:06:15 INFO - 'TMPDIR': '/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/', 07:06:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:06:15 INFO - 'USER': 'cltbld', 07:06:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:06:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:06:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:15 INFO - 'XPC_FLAGS': '0x0', 07:06:15 INFO - 'XPC_SERVICE_NAME': '0', 07:06:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:06:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:16 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:06:16 INFO - Cleaning up... 07:06:16 INFO - Return code: 0 07:06:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:06:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1021d5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021d8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98a1486040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101fb3d30>, '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 0x101edadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101fa8be8>, '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.SSZtr2Gfs5/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.iOpxd0UoZA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/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 07:06:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:06:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:06:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SSZtr2Gfs5/Render', 07:06:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:06:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:06:16 INFO - 'HOME': '/Users/cltbld', 07:06:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:06:16 INFO - 'LOGNAME': 'cltbld', 07:06:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:16 INFO - 'MOZ_NO_REMOTE': '1', 07:06:16 INFO - 'NO_EM_RESTART': '1', 07:06:16 INFO - 'PAGER': '/bin/cat', 07:06:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:06:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:16 INFO - 'PWD': '/builds/slave/test', 07:06:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:06:16 INFO - 'SHELL': '/bin/bash', 07:06:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iOpxd0UoZA/Listeners', 07:06:16 INFO - 'TMPDIR': '/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/', 07:06:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:06:16 INFO - 'USER': 'cltbld', 07:06:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:06:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:06:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:16 INFO - 'XPC_FLAGS': '0x0', 07:06:16 INFO - 'XPC_SERVICE_NAME': '0', 07:06:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:06:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:16 INFO - Downloading/unpacking blobuploader==1.2.4 07:06:16 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 07:06:16 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 07:06:16 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 07:06:16 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 07:06:16 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 07:06:16 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 07:06:19 INFO - Downloading blobuploader-1.2.4.tar.gz 07:06:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:06:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:06:19 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 07:06:19 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 07:06:19 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 07:06:19 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 07:06:19 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 07:06:19 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 07:06:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:06:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:06:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:20 INFO - Downloading docopt-0.6.1.tar.gz 07:06:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:06:20 INFO - Installing collected packages: blobuploader, requests, docopt 07:06:20 INFO - Running setup.py install for blobuploader 07:06:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:06:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:06:20 INFO - Running setup.py install for requests 07:06:21 INFO - Running setup.py install for docopt 07:06:21 INFO - Successfully installed blobuploader requests docopt 07:06:21 INFO - Cleaning up... 07:06:21 INFO - Return code: 0 07:06:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:06:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:21 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 0x1021d5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021d8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98a1486040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101fb3d30>, '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 0x101edadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101fa8be8>, '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.SSZtr2Gfs5/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.iOpxd0UoZA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/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 07:06:21 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 07:06:21 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 07:06:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SSZtr2Gfs5/Render', 07:06:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:06:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:06:21 INFO - 'HOME': '/Users/cltbld', 07:06:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:06:21 INFO - 'LOGNAME': 'cltbld', 07:06:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:21 INFO - 'MOZ_NO_REMOTE': '1', 07:06:21 INFO - 'NO_EM_RESTART': '1', 07:06:21 INFO - 'PAGER': '/bin/cat', 07:06:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:06:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:21 INFO - 'PWD': '/builds/slave/test', 07:06:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:06:21 INFO - 'SHELL': '/bin/bash', 07:06:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iOpxd0UoZA/Listeners', 07:06:21 INFO - 'TMPDIR': '/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/', 07:06:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:06:21 INFO - 'USER': 'cltbld', 07:06:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:06:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:06:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:21 INFO - 'XPC_FLAGS': '0x0', 07:06:21 INFO - 'XPC_SERVICE_NAME': '0', 07:06:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:06:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:06:21 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-jvEUNT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:06:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:06:21 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-jp_auj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:06:22 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-xXgZof-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:06:22 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-xS3OTV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:06:22 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-RGiRfP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:06:22 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-cvbCoP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:06:22 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-v1rbSz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:06:22 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-ZIvQ_8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:06:22 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-HJcB8E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:06:22 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-MgQE24-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:06:22 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-AwhBYL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:06:22 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-r0GBtC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:06:23 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-9EU_3K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:06:23 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-d1QsTD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:06:23 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-tpBJel-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:06:23 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-F11Fdz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:06:23 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-sqT5KC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:06:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:06:23 INFO - Running setup.py install for manifestparser 07:06:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:06:23 INFO - Running setup.py install for mozcrash 07:06:23 INFO - Running setup.py install for mozdebug 07:06:24 INFO - Running setup.py install for mozdevice 07:06:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:06:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:06:24 INFO - Running setup.py install for mozfile 07:06:24 INFO - Running setup.py install for mozhttpd 07:06:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:06:24 INFO - Running setup.py install for mozinfo 07:06:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:06:24 INFO - Running setup.py install for mozInstall 07:06:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:06:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:06:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:06:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:06:24 INFO - Running setup.py install for mozleak 07:06:24 INFO - Running setup.py install for mozlog 07:06:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:06:25 INFO - Running setup.py install for moznetwork 07:06:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:06:25 INFO - Running setup.py install for mozprocess 07:06:25 INFO - Running setup.py install for mozprofile 07:06:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:06:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:06:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:06:25 INFO - Running setup.py install for mozrunner 07:06:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:06:25 INFO - Running setup.py install for mozscreenshot 07:06:25 INFO - Running setup.py install for moztest 07:06:26 INFO - Running setup.py install for mozversion 07:06:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:06:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:06:26 INFO - Cleaning up... 07:06:26 INFO - Return code: 0 07:06:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:06:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:26 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 0x1021d5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021d8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98a1486040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101fb3d30>, '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 0x101edadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101fa8be8>, '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.SSZtr2Gfs5/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.iOpxd0UoZA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/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 07:06:26 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 07:06:26 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 07:06:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SSZtr2Gfs5/Render', 07:06:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:06:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:06:26 INFO - 'HOME': '/Users/cltbld', 07:06:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:06:26 INFO - 'LOGNAME': 'cltbld', 07:06:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:26 INFO - 'MOZ_NO_REMOTE': '1', 07:06:26 INFO - 'NO_EM_RESTART': '1', 07:06:26 INFO - 'PAGER': '/bin/cat', 07:06:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:06:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:26 INFO - 'PWD': '/builds/slave/test', 07:06:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:06:26 INFO - 'SHELL': '/bin/bash', 07:06:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iOpxd0UoZA/Listeners', 07:06:26 INFO - 'TMPDIR': '/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/', 07:06:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:06:26 INFO - 'USER': 'cltbld', 07:06:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:06:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:06:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:26 INFO - 'XPC_FLAGS': '0x0', 07:06:26 INFO - 'XPC_SERVICE_NAME': '0', 07:06:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:06:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:06:26 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-pOsk6w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:06:26 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)) 07:06:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:06:26 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-Z8nePb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:06:26 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)) 07:06:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:06:26 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-hmQe7Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:06:26 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)) 07:06:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:06:26 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-vTiDCu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:06:26 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)) 07:06:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:06:26 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-p0ZVWG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:06:27 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)) 07:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:06:27 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-4oneHx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:06:27 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)) 07:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:06:27 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-TJYIIP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:06:27 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)) 07:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:06:27 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-Deabk3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:06:27 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)) 07:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:06:27 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-aX9MJb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:06:27 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)) 07:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:06:27 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-ZeqK9n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:06:27 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)) 07:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:06:27 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-l5yl5k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:06:27 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)) 07:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:06:27 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-UXxUTo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:06:27 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)) 07:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:06:27 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-1EwfTQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:06:27 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)) 07:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:06:27 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-nlm93w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:06:27 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)) 07:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:06:27 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-R2WM4T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:06:28 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)) 07:06:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:06:28 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-9TEBFs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:06:28 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)) 07:06:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:06:28 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-0mSY_3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:06:28 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)) 07:06:28 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)) 07:06:28 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)) 07:06:28 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)) 07:06:28 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)) 07:06:28 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)) 07:06:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:06:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:31 INFO - Downloading blessings-1.6.tar.gz 07:06:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:06:31 INFO - Installing collected packages: blessings 07:06:31 INFO - Running setup.py install for blessings 07:06:32 INFO - Successfully installed blessings 07:06:32 INFO - Cleaning up... 07:06:32 INFO - Return code: 0 07:06:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:06:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:06:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:06:32 INFO - Reading from file tmpfile_stdout 07:06:32 INFO - Current package versions: 07:06:32 INFO - blessings == 1.6 07:06:32 INFO - blobuploader == 1.2.4 07:06:32 INFO - docopt == 0.6.1 07:06:32 INFO - functools32 == 3.2.3-2 07:06:32 INFO - jsonschema == 2.5.1 07:06:32 INFO - manifestparser == 1.1 07:06:32 INFO - mozInstall == 1.12 07:06:32 INFO - mozcrash == 1.0 07:06:32 INFO - mozdebug == 0.1 07:06:32 INFO - mozdevice == 0.49 07:06:32 INFO - mozfile == 1.2 07:06:32 INFO - mozhttpd == 0.7 07:06:32 INFO - mozinfo == 0.9 07:06:32 INFO - mozleak == 0.1 07:06:32 INFO - mozlog == 3.4 07:06:32 INFO - moznetwork == 0.27 07:06:32 INFO - mozprocess == 0.24 07:06:32 INFO - mozprofile == 0.28 07:06:32 INFO - mozrunner == 6.13 07:06:32 INFO - mozscreenshot == 0.1 07:06:32 INFO - mozsystemmonitor == 0.3 07:06:32 INFO - moztest == 0.8 07:06:32 INFO - mozversion == 1.4 07:06:32 INFO - psutil == 3.1.1 07:06:32 INFO - requests == 1.2.3 07:06:32 INFO - wsgiref == 0.1.2 07:06:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:06:32 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')]} 07:06:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:32 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')]} 07:06:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:32 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 0x1021d5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021d8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98a1486040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101fb3d30>, '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 0x101edadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101fa8be8>, '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.SSZtr2Gfs5/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.iOpxd0UoZA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/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 07:06:32 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 07:06:32 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 07:06:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SSZtr2Gfs5/Render', 07:06:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:06:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:06:32 INFO - 'HOME': '/Users/cltbld', 07:06:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:06:32 INFO - 'LOGNAME': 'cltbld', 07:06:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:32 INFO - 'MOZ_NO_REMOTE': '1', 07:06:32 INFO - 'NO_EM_RESTART': '1', 07:06:32 INFO - 'PAGER': '/bin/cat', 07:06:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:06:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:32 INFO - 'PWD': '/builds/slave/test', 07:06:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:06:32 INFO - 'SHELL': '/bin/bash', 07:06:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iOpxd0UoZA/Listeners', 07:06:32 INFO - 'TMPDIR': '/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/', 07:06:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:06:32 INFO - 'USER': 'cltbld', 07:06:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:06:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:06:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:32 INFO - 'XPC_FLAGS': '0x0', 07:06:32 INFO - 'XPC_SERVICE_NAME': '0', 07:06:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:06:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:32 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)) 07:06:32 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)) 07:06:32 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)) 07:06:32 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)) 07:06:32 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)) 07:06:32 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)) 07:06:32 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)) 07:06:32 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)) 07:06:32 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)) 07:06:32 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)) 07:06:32 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)) 07:06:32 INFO - Cleaning up... 07:06:32 INFO - Return code: 0 07:06:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:06:32 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')]} 07:06:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:32 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')]} 07:06:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:32 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 0x1021d5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021d8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98a1486040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101fb3d30>, '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 0x101edadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101fa8be8>, '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.SSZtr2Gfs5/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.iOpxd0UoZA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/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 07:06:32 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 07:06:32 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 07:06:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SSZtr2Gfs5/Render', 07:06:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:06:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:06:32 INFO - 'HOME': '/Users/cltbld', 07:06:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:06:32 INFO - 'LOGNAME': 'cltbld', 07:06:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:32 INFO - 'MOZ_NO_REMOTE': '1', 07:06:32 INFO - 'NO_EM_RESTART': '1', 07:06:32 INFO - 'PAGER': '/bin/cat', 07:06:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:06:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:32 INFO - 'PWD': '/builds/slave/test', 07:06:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:06:32 INFO - 'SHELL': '/bin/bash', 07:06:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iOpxd0UoZA/Listeners', 07:06:32 INFO - 'TMPDIR': '/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/', 07:06:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:06:32 INFO - 'USER': 'cltbld', 07:06:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:06:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:06:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:32 INFO - 'XPC_FLAGS': '0x0', 07:06:32 INFO - 'XPC_SERVICE_NAME': '0', 07:06:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:06:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:06:32 INFO - Cleaning up... 07:06:32 INFO - Return code: 0 07:06:32 INFO - Running post-action listener: _resource_record_post_action 07:06:32 INFO - Running post-action listener: _start_resource_monitoring 07:06:32 INFO - Starting resource monitoring. 07:06:33 INFO - [mozharness: 2017-01-18 15:06:33.004490Z] Finished create-virtualenv step (success) 07:06:33 INFO - [mozharness: 2017-01-18 15:06:33.005376Z] Running install step. 07:06:33 INFO - Running pre-action listener: _resource_record_pre_action 07:06:33 INFO - Running main action method: install 07:06:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:06:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:06:33 INFO - Reading from file tmpfile_stdout 07:06:33 INFO - Detecting whether we're running mozinstall >=1.0... 07:06:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:06:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:06:33 INFO - Reading from file tmpfile_stdout 07:06:33 INFO - Output received: 07:06:33 INFO - Usage: mozinstall [options] installer 07:06:33 INFO - Options: 07:06:33 INFO - -h, --help show this help message and exit 07:06:33 INFO - -d DEST, --destination=DEST 07:06:33 INFO - Directory to install application into. [default: 07:06:33 INFO - "/builds/slave/test"] 07:06:33 INFO - --app=APP Application being installed. [default: firefox] 07:06:33 INFO - mkdir: /builds/slave/test/build/application 07:06:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:06:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 07:06:55 INFO - Reading from file tmpfile_stdout 07:06:55 INFO - Output received: 07:06:55 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 07:06:55 INFO - Running post-action listener: _resource_record_post_action 07:06:55 INFO - [mozharness: 2017-01-18 15:06:55.708097Z] Finished install step (success) 07:06:55 INFO - [mozharness: 2017-01-18 15:06:55.708236Z] Running run-tests step. 07:06:55 INFO - Running pre-action listener: _resource_record_pre_action 07:06:55 INFO - Running main action method: run_tests 07:06:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:06:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:06:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:06:55 INFO - 2017-01-18 07:06:55.722 screenresolution[1959:14184] starting screenresolution argv=screenresolution get 07:06:55 INFO - 2017-01-18 07:06:55.725 screenresolution[1959:14184] Display 0: 1600x1200x32@60 07:06:55 INFO - 2017-01-18 07:06:55.731 screenresolution[1960:14186] starting screenresolution argv=screenresolution list 07:06:55 INFO - Available Modes on Display 0 07:06:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:06:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:06:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:06:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:06:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:06:55 INFO - Intel Iris: 07:06:55 INFO - Chipset Model: Intel Iris 07:06:55 INFO - Type: GPU 07:06:55 INFO - Bus: Built-In 07:06:55 INFO - VRAM (Dynamic, Max): 1536 MB 07:06:55 INFO - Vendor: Intel (0x8086) 07:06:55 INFO - Device ID: 0x0a2e 07:06:55 INFO - Revision ID: 0x0009 07:06:55 INFO - Displays: 07:06:55 INFO - Display: 07:06:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:06:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:06:55 INFO - Display Serial Number: 1600x1200 60 07:06:55 INFO - Main Display: Yes 07:06:55 INFO - Mirror: Off 07:06:55 INFO - Online: Yes 07:06:55 INFO - Rotation: Supported 07:06:55 INFO - Return code: 0 07:06:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:06:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:06:55 INFO - Python 2.7.3 07:06:55 INFO - Return code: 0 07:06:55 INFO - grabbing minidump binary from tooltool 07:06:55 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')]} 07:06:55 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 0x101fb3d30>, '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 0x101edadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101fa8be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:06:55 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 07:06:55 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 07:06:55 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 07:06:56 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:06:56 INFO - Return code: 0 07:06:56 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:06:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:06:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:06:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:06:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:06:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HaHq5S69Roi59vRIAd8-PA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0351', '--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 07:06:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Graphics --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HaHq5S69Roi59vRIAd8-PA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0351 --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 07:06:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SSZtr2Gfs5/Render', 07:06:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:06:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:06:56 INFO - 'HOME': '/Users/cltbld', 07:06:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:06:56 INFO - 'LOGNAME': 'cltbld', 07:06:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:06:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:06:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:56 INFO - 'MOZ_NO_REMOTE': '1', 07:06:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:06:56 INFO - 'NO_EM_RESTART': '1', 07:06:56 INFO - 'PAGER': '/bin/cat', 07:06:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:06:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:56 INFO - 'PWD': '/builds/slave/test', 07:06:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:06:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:06:56 INFO - 'SHELL': '/bin/bash', 07:06:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iOpxd0UoZA/Listeners', 07:06:56 INFO - 'TMPDIR': '/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/', 07:06:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:06:56 INFO - 'USER': 'cltbld', 07:06:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:06:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:06:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:56 INFO - 'XPC_FLAGS': '0x0', 07:06:56 INFO - 'XPC_SERVICE_NAME': '0', 07:06:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:06:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HaHq5S69Roi59vRIAd8-PA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0351', '--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 07:06:56 INFO - mozversion application_buildid: 20170118050726 07:06:56 INFO - mozversion application_changeset: 8fcc95d1411532306d08b49471214e0f0fcd7a8c 07:06:56 INFO - mozversion application_display_name: Nightly 07:06:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:06:56 INFO - mozversion application_name: Firefox 07:06:56 INFO - mozversion application_remotingname: firefox 07:06:56 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 07:06:56 INFO - mozversion application_vendor: Mozilla 07:06:56 INFO - mozversion application_version: 53.0a1 07:06:56 INFO - mozversion platform_buildid: 20170118050726 07:06:56 INFO - mozversion platform_changeset: 8fcc95d1411532306d08b49471214e0f0fcd7a8c 07:06:56 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 07:06:56 INFO - mozversion platform_version: 53.0a1 07:06:56 INFO - using testdate: 1484752016 07:06:56 INFO - actual date: 1484752016 07:06:56 INFO - starting webserver on 'localhost:49667' 07:06:56 INFO - SUITE-START | Running 2 tests 07:06:56 INFO - TEST-START | dromaeo_css 07:06:56 INFO - operating with platform_type : mac_ 07:06:56 INFO - Initialising browser for dromaeo_css test... 07:06:56 INFO - TEST-INFO | started process 1970 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/tmpZKcQH3/profile http://localhost:49667/getInfo.html) 07:06:58 INFO - PROCESS | 1970 | 2017-01-18 07:06:58.998 plugin-container[1972:14332] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d3f, name = 'com.apple.tsm.portname' 07:06:59 INFO - PROCESS | 1970 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:06:59 INFO - PROCESS | 1970 | 2017-01-18 07:06:59.001 plugin-container[1972:14332] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4c47, name = 'com.apple.CFPasteboardClient' 07:06:59 INFO - PROCESS | 1970 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:06:59 INFO - PROCESS | 1970 | 2017-01-18 07:06:59.001 plugin-container[1972:14332] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:06:59 INFO - PROCESS | 1970 | __metrics Screen width/height:1600/1200 07:06:59 INFO - PROCESS | 1970 | colorDepth:24 07:06:59 INFO - PROCESS | 1970 | Browser inner width/height: 1024/689 07:06:59 INFO - PROCESS | 1970 | __metrics 07:06:59 ERROR - PROCESS | 1970 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3253: TypeError: this.tabs is undefined 07:06:59 INFO - TEST-INFO | 1970: exit 0 07:06:59 INFO - Browser initialized. 07:06:59 INFO - Running cycle 1/1 for dromaeo_css test... 07:06:59 INFO - TEST-INFO | started process 1973 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/tmpZKcQH3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:07:02 INFO - PROCESS | 1973 | 2017-01-18 07:07:02.243 plugin-container[1974:14455] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a3f, name = 'com.apple.tsm.portname' 07:07:02 INFO - PROCESS | 1973 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:07:02 INFO - PROCESS | 1973 | 2017-01-18 07:07:02.244 plugin-container[1974:14455] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x453f, name = 'com.apple.CFPasteboardClient' 07:07:02 INFO - PROCESS | 1973 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:07:02 INFO - PROCESS | 1973 | 2017-01-18 07:07:02.244 plugin-container[1974:14455] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:07:11 INFO - PROCESS | 1973 | RSS: Main: 233394176 07:07:11 INFO - PROCESS | 1973 | 07:10:14 INFO - PROCESS | 1973 | Cycle 1(1): loaded http://localhost:49667/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49667/tests/dromaeo/cssquery-ext.html) 07:10:16 INFO - PROCESS | 1973 | RSS: Main: 250675200 07:10:16 INFO - PROCESS | 1973 | 07:12:00 INFO - PROCESS | 1973 | ************************* 07:12:00 INFO - PROCESS | 1973 | A coding exception was thrown and uncaught in a Task. 07:12:00 INFO - PROCESS | 1973 | 07:12:00 ERROR - PROCESS | 1973 | Full message: TypeError: NetworkError when attempting to fetch resource. 07:12:00 INFO - PROCESS | 1973 | Full stack: 07:12:00 INFO - PROCESS | 1973 | ************************* 07:13:18 INFO - PROCESS | 1973 | Cycle 1(1): loaded http://localhost:49667/tests/dromaeo/cssquery-ext.html (next: http://localhost:49667/tests/dromaeo/cssquery-jquery.html) 07:13:19 INFO - PROCESS | 1973 | RSS: Main: 259465216 07:13:19 INFO - PROCESS | 1973 | 07:16:21 INFO - PROCESS | 1973 | Cycle 1(1): loaded http://localhost:49667/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49667/tests/dromaeo/cssquery-mootools.html) 07:16:21 INFO - PROCESS | 1973 | RSS: Main: 268898304 07:16:21 INFO - PROCESS | 1973 | 07:19:23 INFO - PROCESS | 1973 | Cycle 1(1): loaded http://localhost:49667/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49667/tests/dromaeo/cssquery-prototype.html) 07:19:24 INFO - PROCESS | 1973 | RSS: Main: 267509760 07:19:24 INFO - PROCESS | 1973 | 07:22:27 INFO - PROCESS | 1973 | Cycle 1(1): loaded http://localhost:49667/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49667/tests/dromaeo/cssquery-yui.html) 07:22:27 INFO - PROCESS | 1973 | RSS: Main: 271867904 07:22:27 INFO - PROCESS | 1973 | 07:25:30 INFO - PROCESS | 1973 | Cycle 1(1): loaded http://localhost:49667/tests/dromaeo/cssquery-yui.html (next: http://localhost:49667/tests/dromaeo/cssquery-dojo.html) 07:25:30 INFO - PROCESS | 1973 | RSS: Main: 274337792 07:25:30 INFO - PROCESS | 1973 | 07:25:30 INFO - PROCESS | 1973 | __start_tp_report 07:25:30 INFO - PROCESS | 1973 | _x_x_mozilla_page_load 07:25:30 INFO - PROCESS | 1973 | _x_x_mozilla_page_load_details 07:25:30 INFO - PROCESS | 1973 | |i|pagename|runs| 07:25:30 INFO - PROCESS | 1973 | |0;dojo.html;2842.687304396516;3340.114869559567;3384.2216290253227;3396.269801992571;3410.266792639583;5518.420565840579;5554.055810512213;5575.581831362644;5575.8606034849145;5624.803131890385;4522.728636281825;5545.805896793613;5558.610897237195;5594.13290939904;5595.1886976388505;3881.592432794558;5082.872928176788;5109.744512774365;5214.296070030554;5216.139337009389;5041.949580504203;5210.088234558956;5234.18870075139;5251.606129540281;5274;5056.469070747556;5073.518015788494;5170.741462926876;5176.430592634807;5185.55922746567;5059.16523773577;5134.743262836881;5187.48125187482;5209.01028804526;5245.921311180336;5085.898282034375;5088.745562721849;5117.513836185593;5141.76862041209;5142.691438513663;4369.584889435499;5589.217509548666;5641.802536911188;5647.519960803336;5653.378128405913;6089.908651370233;6100.847478813021;6106.157323464386;6111.87776244477;6134.405972711579;6207.875842483125;6289.7169627366875;6290.559660823744;6293;6301.6534090625;5785.855353616151;5799.623024503394;5802.0426629605645;5822.621529600562;5841.883162336772;5984.31180414258;6221.097940798559;6228;6296.118543403927;6309.968450157719;5127.179651255781;5988.760449582055;6014.729337179838;6092.39076092396;6103.938960610426;6243.032329988859;6243.96878015607;6270.059491076284;6282.591631543935;6302.432781049728;6062.090686396988;6114.11345354921;6131.957816600026;6213.844653883599;6247.312795592481;6016.217891674142;6240.5319601030105;6245.313015568284;6245.531585131133;6267.71795269214;4859.392575928009;4883.731394773251;4894.681845680019;4898.8775280618265;4924.162892308316;4382.758948257812;4389.539098394686;4406.889827754268;4421.447319085114;4458.665600080007;4811.542903424169;4811.831585894547;5783.450572195635;5814.360420353758;5815.79644712433;6108.251008765781;6111.51107911366;6183.628982261079;6187.443130118221;6220.253569571681;5828.242328497268;5874.236349274567;5874.265716785402;5948.899453601098;5963.731632076567;5003.324551185616;5400.324959380077;5405.135178371442;5407.891842163213;5420.701861397582;6068.605540639845;6233.96883015582;6267.341929097379;6301.527385446018;6320.336364681734;4504.684672072924;5073.213651883964;6114.449440885012;6168.228971378578;6282.874342513215;6293.118963345227;6306.4639505642535;6315.810525684236;6327.570700509754;6370.044493326038;6166.414190651881;6166.660833654192;6178.104174894705;6181.907271390843;6222.377762223922;4578.9771051144535;5598.740283436195;6090.7148889660975;6125.204929265209;6214.5028397728975;6027.75888964454;6035.728392222272;6107.206063211754;6115.174451448997;6132.325444201224;5163.870903227299;5959.106134079922;6057.394260573908;6066.4540191382985;6080.027195648675;5006.574441172541;5550.583706221969;5737.8524295140305;5930.822075337746;5987.550933680079;6107.755689772537;6110.877782444415;6112.510999119971;6113.174721412553;6163;5505.834824955257;5636.2954630671165;5879;5940.108983652487;5962.791302304398 07:25:30 INFO - PROCESS | 1973 | |1;ext.html;424.40371278353916;444.6353989728424;465.030411591831;471.2954133570313;540.2652392745865;38718.80640596797;41384.37923431151;41444.17111657765;41601.79199104004;41716.37425438621;42671.78664106675;43223.78388108063;43235.56764432362;43350;44016.497937757784;8137.593120343989;9227.584758685858;9483.95676475587;10748.140148788078;11052.171087168454;10959.780804383907;11106.222564420494;11109.44452777362;11113.944430277837;11120.666380008613;11111.833322500128;11144.60993865215;11144.944275278613;11165.832512512277;11175.552977880876;11058.060064894493;11104.44477776108;11111.555537778479;11132.833007504894;11156.832647510293;10770.4614769262;10968.341899485977;10973.177011724152;10991.285566438157;11008.339499629968;36651.26697466036;36990.815045924865;37066.62933370686;37150.814245928595;37213.62786372129;3897.629725176104;3921.8235179416993;3945.3687410014545;3954.9321683145677;4041.818118184689;27697.584536231974;28480.857595712096;28680.569791453145;28697;28736.281592960135;3137.7646676499353;3244.935101297961;3247.4966380211104;3318.286568387808;3324.667533246656;405579;472158;479821;480038;481209;55075.724621376634;55254;55263.723681381336;55654.72172639111;55829.44170558324;55936.720316398154;56423.15365269524;56441.71779141078;56444;56552.717236413555;14890.106593604418;15316;15320.310586023656;15428.691426171414;15446.304916278794;10590.417527035934;10871.402072886067;11634.301941883514;11906.52373905034;11935;15164.772528412082;15884.046957182374;16434.506964791075;17715.73426398605;17848.107594620476;6571.9156339204455;7678.232176782389;7712.845743085107;7768.184340644264;7807.960960195162;840.5797101449275;843.932425481766;866.1814585217036;867.5878957495139;883.7569668341257;29133.12600621985;29737.851310743306;29969;30178.09465716032;30553.38893222123;959.9904000959901;1038.2161468091695;1047.7694907120422;1082.231615552966;1176.0591526778544;15723.528294151194;15742.68514629701;15762.842371576138;15775.211239437982;16036.438724644815;656640;661110;661291;661836;663480;46913;47270.32756069225;47387.289190662166;47538.81152971203;47572.5242747575;1401.0332870319446;1441.9206943617992;1462.8098347215007;1463.4219483304034;1464.392277204948;25660.358491037874;26241.81911813935;29650.555241671824;30244.697553025067;30736.385272294876;50991.2351314738;51374.22938655849;51396;51558.74220628873;51571.484285156665;557556;561730;562798;563061;563536;25493;26424.471510570067;26450.735492644828;26492.94028238849;26556.601650974866;47130.764346178046;47250;48286.75856620695;48427.03145937132;48545;38523;38552.614473854905;39036.609633903296;39963.60036399599;40345.79827100963;38101;38286.042848929;38556.42165367465;39724.20551588894;39770.80114599524;37622.62377376191;38476.615233847304;38502.42246366363;38557.807210963765;38644.227115458096;27291.044813431436;30007.549886752153;32616.673833261364;34107.488387674704;34348.82825585856;21320.893395532923;24715.50568988646;25040.62439063452;25603.6159457612;25605.871970640772 07:25:30 INFO - PROCESS | 1973 | |2;jquery.html;374.9962500374997;375.90790256387186;386.39336242099904;389.25069241709735;405.4971834924692;18651.1606977686;19125.426237212872;20941.581168376622;21157.942102894853;21185.258515951944;11844.230125041888;12028.037756979442;12219.266843989366;12235.571754988578;12248.877511224886;5068.873278168038;5373.328333958255;5382.730863456831;5389.191621256804;5391.595630327722;3930.351492003816;4143.937840932388;4487.326900964865;5320.787168513255;6117.021276595746;6136.7545298188015;6144.44699977002;6145.569810113294;6153.369357120367;6158.907616385758;6035.758569657209;6545.083688283644;6620.503462240351;6626.7017984190825;6647.069410282588;4971.751412429364;5625.324961004665;5854.20968169296;5887.8528036799;5893.791772686589;12794;13169.670758231025;20417.5916481671;20566.897165514227;25607.359816004562;2598.1296265751;2815.53543665295;2925.3710452252867;2935.765138788892;2936.4420760055737;10164.695059148238;10178.9491052545;10217.029382208679;10585.04734573892;10585.894141058568;1834.0279651784576;1893.9242430302909;1905.90470476477;1912.6174765047047;1912.8278454939123;113104;135490;138870.3056484711;141290.5870941298;141944.58055419417;9241.953790231006;9645.662401815904;11258.155638327158;11712.88287117135;11916.285022898654;13641.522546710818;14814.777778333333;15171.468998584996;15482.071075735492;15487.457938972082;8478.830423391497;8681.175288347597;8714;8717.12828717136;8758.036615972238;8354.707585234488;8432.45189062709;8470.534120623424;8568.143185681382;8612.698555550525;3875.457435958968;4720.12677654635;4728.574428301469;4779.187538118528;4787.234042553175;1665.1424516374077;1747.6242607839122;1755.9034253116201;1992.4221975627195;2042;905.4160066757037;994.1450352696675;994.3834822410151;1011.1607365886443;1019.4342140112309;18171.727979041603;20102;21367.57264854725;21771.891140544514;21891;1028.8199565076081;1031.5409642709074;1050.9842352364722;1076.1229597877705;1077.7359546911057;10937.617183398543;11712.531498740125;11746.119041071783;11768.35274059935;11779.411029448493;672800;740588;742346;742905;769969;105161;123829;152086;153033.46966530193;156008;1012.2408193854609;1029.6190409548515;1050.1703654113164;1052.1267348101057;1055.994720026395;18994.810051899858;19079.904600476908;19128.617427651647;19235.90382048081;19370.903145484746;57879.71060144672;57915;59740.70129649324;60573.69713151406;60731.48171295753;84172.57913710392;84225.15774842173;84891.15108849079;85441.29117417742;86933;7412.518186317872;7672.002639656809;8171.142030086755;8315.667373305;8434.650455927022;10285.640002599874;12758.362081896053;12800.423980920694;13166.736665266833;13620.591382258548;10653.254272200871;11031.338119712844;11087.55649774;11202.103831693608;11231.045361144394;10635.94682026585;11002.889971100187;11259.380734059705;11290.018739031757;11415.258008229439;9632.532288376038;11021.173411994292;11393.772124557629;11494.252873563191;11749;6682.899756503559;6916.170059592881;7181.210066892742;7310.232425595236;8581.97016358041;7175.641217939186;7868.921310786819;8413.537255451009;9942;10657.733556661145 07:25:30 INFO - PROCESS | 1973 | |3;mootools.html;1404.8103506026682;1432.8710416062556;1451.7677171652524;1480.9337277160448;1495.678429137735;6376.713047912844;7815.218478152182;8095.514269143848;8550.230479256858;8583.18459746324;7957.960210198956;8265.504069755803;8281.91718082819;8376.45553039052;8406.831863362744;1936.786953435128;2268.27415227127;2307.2040146149634;2318.8869342715507;2322.8722420266877;2298.390926404504;2324.895379707917;2338.929832105031;2340.4031971847157;2351.988240058797;2294.804941579968;2309.618912879373;2311.3297143828354;2325.2442956039354;2327.976720232793;2280.566692328452;2285.1430713482446;2306.5848147333472;2308.653701944705;2312.6184179610345;1881.369741136721;2334.7548507406646;2335.404471859665;2342.730585982617;2349.3539276698875;8417.873731894026;8444.915550844475;8463.788405289855;8488.915110848875;8493.787655308604;5019.19692849146;5187.351581052369;5192.688438693691;5199.376074871002;5201.817936372247;3273.8363081845814;3337.8998630041137;3455.58532976042;3504.8072356020407;3550.55618047744;1198.1253684810051;1206.4329765010432;1214.3563911127117;1230.6308107567693;1243.8258643789877;10630.78738425235;10700.892991070068;10721.249512534127;10765.246432749711;10782.353058816496;4394.406755088022;4619.2609182531305;4687.109449204709;4697.271922851964;4707.552782485658;9462.29032822541;9509.096635819586;9517.428954262767;9521.000294968928;9544.952275238718;5212;5242.18746094356;5254.789808407697;5256;5259.658122222043;4165.854195103157;4672.672912896064;4695.060987802453;4726.9600687848615;4806.423229212517;3781.5273090863643;3815.923681526354;3865.980670096688;3903.863364782219;3928.253631809947;1162.4071723420948;1266.202292555684;1269.136986848933;1274.9808752868714;1275.101053757099;756.8334966307403;761.497411708281;849.3290300662532;867.2021739999216;868.9391742577959;4141.378793181047;4852.441969173519;4860.854174374775;5252.684838909678;5360.927814437128;507.70517261976397;554.972251387429;558.1906235957878;561.3376216065083;569.4021277658442;2883.7548808351107;3417.6582341765625;3477.2523907360037;3477.51314815926;3583.33708263972;9048.592813323416;9689.467079310565;9981.351212171186;10069.949650251701;10074.546645400975;8260.29787468072;9167;9969.202463802878;10012.69961901144;10031.297809153435;5998.310194327621;7568.940348351235;7835.84328313442;7856.45004849655;7861.960690196513;5018.874528136826;5108.923366149436;5140.357455318085;5171.663841850268;5283.498067683564;7046.506744528039;9058.456492610465;9117.179453849185;9196.58615362297;9314.906850931675;9113.316501262565;9122.407043542149;9232.261419086592;9353;9355.766105847408;5775.826725198251;6592.110065141144;6794.335387830013;6989.5107342485535;7215.819604509929;6376.521760868046;7836.568988705676;7979.241972012649;7993.280604745601;8029.237222463857;7033.085698859116;7201.747938822116;7203.171635261802;7241;7299.5620262784405;7032.331928466788;7241.203467618452;7334.339909408179;7376.4098872089035;7448.329650331496;5475.890482190413;6296.307406185408;6310.6213627182515;6415.133956915756;6420.550561460653;4689.601383882272;4813.831515896927;4852.296417019583;4879.682820616648;4894.632902532396;4564.863054108382;4793.5685788279225;4821.807127714992;4907.705537667752;4941.209406494943 07:25:30 INFO - PROCESS | 1973 | |4;prototype.html;348.83953381444536;352.21631869091266;362.26098758532595;362.67540551206656;366.6773239549198;4291.42065821114;4450.71070380425;4590.42619672541;5221.373435187773;5459.563234941205;4416.779161041943;5090.338256026721;5247.055530004598;5273.419923808378;5307.708076055825;4152.231837110129;4155.210510003105;4166.937495937564;4169.249535083683;4189.706720529564;4032.2338755636483;4083.448734420845;4176.786303259278;4183.556672947828;4212.304969679999;4056.3369018702338;4100.671946244293;4103.548609652936;4116.217918595472;4140.648044916185;3448.189675426273;3579.49887015818;3999.98000509871;4087.795610219492;4111.773852438099;2861.5978170696417;3388.8816690492076;3625.8912232633065;3678.797666128362;3684.1894783147663;4304.096139810644;4792.880177995543;4806.2937657131915;5154.969006198775;5199.2184181462735;3905.4922860028014;4445.955540444619;4598.310253461974;4603.089717767122;4622.342153261888;4783.727729328576;5093.567046801027;5309.867253318659;5674.354437213203;5680.971595142039;3409.3010932758725;3565.6612621800887;3700.3154416433044;3827.6937844972335;3849.4225866120028;4970.577500912426;5462.726863656841;5946.791862284799;5981.58128930975;5991.161237426763;3668.779873207616;3886.4753258310334;3931.66580840626;3949;3960.3663413853646;3512.666296701809;3738.925221495609;3956.3669812830385;3973.1259122992897;3994.400839874042;4326.848560300375;4379.861236078579;4560.5895469407915;4583.335416364608;4606.378138951199;5179.792808287626;5333.306670132858;5673.404292549306;5694.9430505695245;5704.976362527784;1172.0447835014436;1211.981820272679;1227.2820400065882;1258.4714419943462;1367.4256812138926;811.8213992921548;856.7986523167051;983.6016413352604;988.1896844587369;991.4200192887241;4291.2061268664775;4458.643308535309;4591.770411479412;5077.289179514871;5116.462771409023;4727.716337019721;4967.875803104879;5295.629305948547;5377.623566350396;5524.696141712164;4419.337099435111;4856.83001094967;5068.366454193226;5088.313077734532;5091.439941606421;2879.3941482957957;2891.6530016397746;2900.8984685535906;2906.4768341698273;2908.4473949949443;5394.136938089887;5479.972600137054;5580.010292640782;5610.719464026783;5768.538516918637;4728.976355118202;4803.663743537989;5033.697978121251;5317.521423071942;5724.912266669319;4917;5180.9740951295;5447.68473398804;5768.596198266081;5799.7521388022;5108.3103780989095;5115.4373018967135;5305.416404195458;5502.532284755681;5531;5116.846494605168;5137.897242055213;5292.3649162099255;5358.544523715528;5417.593680473901;5176.767045483038;5259.973700131475;5805.622634528742;6041.909371359521;6157.261128664589;3920.686345092443;3925.7448265862627;3945.5659877412886;3947.427622994592;3953.822078006554;4958.132326842716;5467.917981230365;5638;5764.596478246483;5777.335606405317;4638.397008388888;4865.635077369141;5175.852021411072;5253.816116435906;5715.828525144252;5179.633238395073;5486.875190585841;5689.943100569107;5705.657660540381;5706.859927527177;5260.263563101093;5467.425920278472;5469.371022332482;5570.2480165177185;5584.3143525274745;4825.372701548777;5387.3804512481565;5651.660900345993;5651.858703532444;5702.173184888251;5569.8024924641395;5570.442955704397;5599.160125980972;5611.156357894855;5626.606137570331 07:25:30 INFO - PROCESS | 1973 | |5;yui.html;715.5849607227808;777.5567926282018;793.3335997761878;810.9351251899849;839.7774589733722;15489.302981365838;16119.435819746312;16132.919335403307;16195.947263427885;16220.188990550485;14913.627159321022;15016.249187540634;15022.173780442072;15061.62345941352;15079;683.5898460923456;702.5082442290417;848.367965865428;850.6044689219497;869.821686554258;866.3242670716851;875.6016012714232;876.9429987050853;876.9561521923911;878.0341624213346;759.7151068349369;906.0893801729253;932.8507438809792;935.8596210568401;936.1060187520935;915.5468043318533;925.7778133248006;930.1535602601667;930.646354385336;931.6878845586737;691.9619420931847;692.2143367278176;694.697806454194;695.4123765418213;695.6730336741774;13334.799978000337;15328.846711532853;15576.376944922189;15637.296321665439;16011.679766404606;14500.41998320066;14592.270386480634;14670.486532971296;14828.777568336483;14940.32768525419;11851.348175850324;11898.345590992492;11968.34174120423;12040.096992725581;12055;3724.683401910841;3754.342989976743;3775.0562359410146;3797.2215695782575;3909.3158697228155;88656.22687546213;89818;106390;107441.46279268553;108842.45578772055;9763.999999999858;11319.943400282946;11688.70778230534;11760.176787624785;11892.702682433008;23841.761582383955;24248.51502969931;24291.906864191154;24294.75705242925;24344.756552434603;6644;7688.115866675404;7743.264389882952;7889.723859664884;7893.092294386104;3675.6691897729334;4241.63946064588;4338.913221735547;4377.277749171415;4434.17967675981;3608.4767708682093;3704.759190652599;3711.628837116267;3715.64701353371;3725.701943844486;563.5092889428735;659.1826135591928;660.7687309441657;669.2370697404962;677.6239187251123;679.8232459560451;684.8185230913812;699.800556841308;713.7038129176334;724.4747558020393;8699.782505437415;10310.484475776331;10458.424786636655;10527.84208236877;10641.361518308771;554.3624831443872;559.829252078112;584.7748616782569;595.2351228671137;595.7780057793444;4234.788260586958;5039.658449687998;5080.441151473335;5106.897862042739;5117.565006974449;103390.48304758428;105424.47287763665;106510;108438;111097;82422.58788706017;87471.1252887463;89497;93410.53294733482;94167;82429.58785206036;84177.15822841816;84773.57613211895;84781;85435.14564854396;9692.515374231401;9811.362261452983;9817.656382026595;9906.356086854332;9945.30382873192;52093.739531302104;52898;53624;54241.72879135579;55924;61619;73411.89882151665;73596;73933;74909.62545187457;10057.346272492265;12002.519899203933;12212.450439730055;12282.877171228174;12636.2418254905;12767.233965962072;12995.610131696065;13076;13155.53955611549;13292.800607990694;9783.853242201514;11484.19610627248;11526.732059473283;11802.76394472123;12355.75288494207;10541.525631346454;11130.387828669502;11271.041961433042;12183.390830458618;12691.93654031724;11903.107266955187;11909.404529773303;11991.243354331233;12135.757284854077;12294.385280736105;9839.311248212556;10466.058054775107;10653.57385704563;10714.678559643224;11050.226484146033;9428.528573571431;10049.598016079568;10071.093601575893;10096.949515252376;10118.291719579558 07:25:30 INFO - PROCESS | 1973 | __end_tp_report 07:25:30 INFO - PROCESS | 1973 | __start_cc_report 07:25:30 INFO - PROCESS | 1973 | _x_x_mozilla_cycle_collect,375 07:25:30 INFO - PROCESS | 1973 | __end_cc_report 07:25:30 INFO - PROCESS | 1973 | __startTimestamp1484753130861__endTimestamp 07:25:30 INFO - PROCESS | 1973 | 07:25:30 INFO - PROCESS | 1973 | ------- Summary: start ------- 07:25:30 INFO - PROCESS | 1973 | Number of tests: 6 07:25:30 INFO - PROCESS | 1973 | 07:25:30 INFO - PROCESS | 1973 | [#0] dojo.html Cycles:165 Average:5627.03 Median:5874.24 stddev:693.77 (11.8%) stddev-sans-first:660.62 07:25:30 INFO - PROCESS | 1973 | Values: 2842.7 3340.1 3384.2 3396.3 3410.3 5518.4 5554.1 5575.6 5575.9 5624.8 4522.7 5545.8 5558.6 5594.1 5595.2 3881.6 5082.9 5109.7 5214.3 5216.1 5041.9 5210.1 5234.2 5251.6 5274.0 5056.5 5073.5 5170.7 5176.4 5185.6 5059.2 5134.7 5187.5 5209.0 5245.9 5085.9 5088.7 5117.5 5141.8 5142.7 4369.6 5589.2 5641.8 5647.5 5653.4 6089.9 6100.8 6106.2 6111.9 6134.4 6207.9 6289.7 6290.6 6293.0 6301.7 5785.9 5799.6 5802.0 5822.6 5841.9 5984.3 6221.1 6228.0 6296.1 6310.0 5127.2 5988.8 6014.7 6092.4 6103.9 6243.0 6244.0 6270.1 6282.6 6302.4 6062.1 6114.1 6132.0 6213.8 6247.3 6016.2 6240.5 6245.3 6245.5 6267.7 4859.4 4883.7 4894.7 4898.9 4924.2 4382.8 4389.5 4406.9 4421.4 4458.7 4811.5 4811.8 5783.5 5814.4 5815.8 6108.3 6111.5 6183.6 6187.4 6220.3 5828.2 5874.2 5874.3 5948.9 5963.7 5003.3 5400.3 5405.1 5407.9 5420.7 6068.6 6234.0 6267.3 6301.5 6320.3 4504.7 5073.2 6114.4 6168.2 6282.9 6293.1 6306.5 6315.8 6327.6 6370.0 6166.4 6166.7 6178.1 6181.9 6222.4 4579.0 5598.7 6090.7 6125.2 6214.5 6027.8 6035.7 6107.2 6115.2 6132.3 5163.9 5959.1 6057.4 6066.5 6080.0 5006.6 5550.6 5737.9 5930.8 5987.6 6107.8 6110.9 6112.5 6113.2 6163.0 5505.8 5636.3 5879.0 5940.1 5962.8 07:25:30 INFO - PROCESS | 1973 | 07:25:30 INFO - PROCESS | 1973 | [#1] ext.html Cycles:180 Average:68987.61 Median:37418.13 stddev:151912.55 (406.0%) stddev-sans-first:152251.48 07:25:30 INFO - PROCESS | 1973 | Values: 424.4 444.6 465.0 471.3 540.3 38718.8 41384.4 41444.2 41601.8 41716.4 42671.8 43223.8 43235.6 43350.0 44016.5 8137.6 9227.6 9484.0 10748.1 11052.2 10959.8 11106.2 11109.4 11113.9 11120.7 11111.8 11144.6 11144.9 11165.8 11175.6 11058.1 11104.4 11111.6 11132.8 11156.8 10770.5 10968.3 10973.2 10991.3 11008.3 36651.3 36990.8 37066.6 37150.8 37213.6 3897.6 3921.8 3945.4 3954.9 4041.8 27697.6 28480.9 28680.6 28697.0 28736.3 3137.8 3244.9 3247.5 3318.3 3324.7 405579.0 472158.0 479821.0 480038.0 481209.0 55075.7 55254.0 55263.7 55654.7 55829.4 55936.7 56423.2 56441.7 56444.0 56552.7 14890.1 15316.0 15320.3 15428.7 15446.3 10590.4 10871.4 11634.3 11906.5 11935.0 15164.8 15884.0 16434.5 17715.7 17848.1 6571.9 7678.2 7712.8 7768.2 7808.0 840.6 843.9 866.2 867.6 883.8 29133.1 29737.9 29969.0 30178.1 30553.4 960.0 1038.2 1047.8 1082.2 1176.1 15723.5 15742.7 15762.8 15775.2 16036.4 656640.0 661110.0 661291.0 661836.0 663480.0 46913.0 47270.3 47387.3 47538.8 47572.5 1401.0 1441.9 1462.8 1463.4 1464.4 25660.4 26241.8 29650.6 30244.7 30736.4 50991.2 51374.2 51396.0 51558.7 51571.5 557556.0 561730.0 562798.0 563061.0 563536.0 25493.0 26424.5 26450.7 26492.9 26556.6 47130.8 47250.0 48286.8 48427.0 48545.0 38523.0 38552.6 39036.6 39963.6 40345.8 38101.0 38286.0 38556.4 39724.2 39770.8 37622.6 38476.6 38502.4 38557.8 38644.2 27291.0 30007.5 32616.7 34107.5 34348.8 21320.9 24715.5 25040.6 25603.6 25605.9 07:25:30 INFO - PROCESS | 1973 | 07:25:30 INFO - PROCESS | 1973 | [#2] jquery.html Cycles:180 Average:39409.32 Median:21276.42 stddev:122268.84 (574.7%) stddev-sans-first:122576.70 07:25:30 INFO - PROCESS | 1973 | Values: 375.0 375.9 386.4 389.3 405.5 18651.2 19125.4 20941.6 21157.9 21185.3 11844.2 12028.0 12219.3 12235.6 12248.9 5068.9 5373.3 5382.7 5389.2 5391.6 3930.4 4143.9 4487.3 5320.8 6117.0 6136.8 6144.4 6145.6 6153.4 6158.9 6035.8 6545.1 6620.5 6626.7 6647.1 4971.8 5625.3 5854.2 5887.9 5893.8 12794.0 13169.7 20417.6 20566.9 25607.4 2598.1 2815.5 2925.4 2935.8 2936.4 10164.7 10178.9 10217.0 10585.0 10585.9 1834.0 1893.9 1905.9 1912.6 1912.8 113104.0 135490.0 138870.3 141290.6 141944.6 9242.0 9645.7 11258.2 11712.9 11916.3 13641.5 14814.8 15171.5 15482.1 15487.5 8478.8 8681.2 8714.0 8717.1 8758.0 8354.7 8432.5 8470.5 8568.1 8612.7 3875.5 4720.1 4728.6 4779.2 4787.2 1665.1 1747.6 1755.9 1992.4 2042.0 905.4 994.1 994.4 1011.2 1019.4 18171.7 20102.0 21367.6 21771.9 21891.0 1028.8 1031.5 1051.0 1076.1 1077.7 10937.6 11712.5 11746.1 11768.4 11779.4 672800.0 740588.0 742346.0 742905.0 769969.0 105161.0 123829.0 152086.0 153033.5 156008.0 1012.2 1029.6 1050.2 1052.1 1056.0 18994.8 19079.9 19128.6 19235.9 19370.9 57879.7 57915.0 59740.7 60573.7 60731.5 84172.6 84225.2 84891.2 85441.3 86933.0 7412.5 7672.0 8171.1 8315.7 8434.7 10285.6 12758.4 12800.4 13166.7 13620.6 10653.3 11031.3 11087.6 11202.1 11231.0 10635.9 11002.9 11259.4 11290.0 11415.3 9632.5 11021.2 11393.8 11494.3 11749.0 6682.9 6916.2 7181.2 7310.2 8582.0 7175.6 7868.9 8413.5 9942.0 10657.7 07:25:30 INFO - PROCESS | 1973 | 07:25:30 INFO - PROCESS | 1973 | [#3] mootools.html Cycles:180 Average:5310.03 Median:5124.64 stddev:2934.82 (57.3%) stddev-sans-first:2928.37 07:25:30 INFO - PROCESS | 1973 | Values: 1404.8 1432.9 1451.8 1480.9 1495.7 6376.7 7815.2 8095.5 8550.2 8583.2 7958.0 8265.5 8281.9 8376.5 8406.8 1936.8 2268.3 2307.2 2318.9 2322.9 2298.4 2324.9 2338.9 2340.4 2352.0 2294.8 2309.6 2311.3 2325.2 2328.0 2280.6 2285.1 2306.6 2308.7 2312.6 1881.4 2334.8 2335.4 2342.7 2349.4 8417.9 8444.9 8463.8 8488.9 8493.8 5019.2 5187.4 5192.7 5199.4 5201.8 3273.8 3337.9 3455.6 3504.8 3550.6 1198.1 1206.4 1214.4 1230.6 1243.8 10630.8 10700.9 10721.2 10765.2 10782.4 4394.4 4619.3 4687.1 4697.3 4707.6 9462.3 9509.1 9517.4 9521.0 9545.0 5212.0 5242.2 5254.8 5256.0 5259.7 4165.9 4672.7 4695.1 4727.0 4806.4 3781.5 3815.9 3866.0 3903.9 3928.3 1162.4 1266.2 1269.1 1275.0 1275.1 756.8 761.5 849.3 867.2 868.9 4141.4 4852.4 4860.9 5252.7 5360.9 507.7 555.0 558.2 561.3 569.4 2883.8 3417.7 3477.3 3477.5 3583.3 9048.6 9689.5 9981.4 10069.9 10074.5 8260.3 9167.0 9969.2 10012.7 10031.3 5998.3 7568.9 7835.8 7856.5 7862.0 5018.9 5108.9 5140.4 5171.7 5283.5 7046.5 9058.5 9117.2 9196.6 9314.9 9113.3 9122.4 9232.3 9353.0 9355.8 5775.8 6592.1 6794.3 6989.5 7215.8 6376.5 7836.6 7979.2 7993.3 8029.2 7033.1 7201.7 7203.2 7241.0 7299.6 7032.3 7241.2 7334.3 7376.4 7448.3 5475.9 6296.3 6310.6 6415.1 6420.6 4689.6 4813.8 4852.3 4879.7 4894.6 4564.9 4793.6 4821.8 4907.7 4941.2 07:25:30 INFO - PROCESS | 1973 | 07:25:30 INFO - PROCESS | 1973 | [#4] prototype.html Cycles:180 Average:4457.78 Median:4963.00 stddev:1335.79 (26.9%) stddev-sans-first:1303.45 07:25:30 INFO - PROCESS | 1973 | Values: 348.8 352.2 362.3 362.7 366.7 4291.4 4450.7 4590.4 5221.4 5459.6 4416.8 5090.3 5247.1 5273.4 5307.7 4152.2 4155.2 4166.9 4169.2 4189.7 4032.2 4083.4 4176.8 4183.6 4212.3 4056.3 4100.7 4103.5 4116.2 4140.6 3448.2 3579.5 4000.0 4087.8 4111.8 2861.6 3388.9 3625.9 3678.8 3684.2 4304.1 4792.9 4806.3 5155.0 5199.2 3905.5 4446.0 4598.3 4603.1 4622.3 4783.7 5093.6 5309.9 5674.4 5681.0 3409.3 3565.7 3700.3 3827.7 3849.4 4970.6 5462.7 5946.8 5981.6 5991.2 3668.8 3886.5 3931.7 3949.0 3960.4 3512.7 3738.9 3956.4 3973.1 3994.4 4326.8 4379.9 4560.6 4583.3 4606.4 5179.8 5333.3 5673.4 5694.9 5705.0 1172.0 1212.0 1227.3 1258.5 1367.4 811.8 856.8 983.6 988.2 991.4 4291.2 4458.6 4591.8 5077.3 5116.5 4727.7 4967.9 5295.6 5377.6 5524.7 4419.3 4856.8 5068.4 5088.3 5091.4 2879.4 2891.7 2900.9 2906.5 2908.4 5394.1 5480.0 5580.0 5610.7 5768.5 4729.0 4803.7 5033.7 5317.5 5724.9 4917.0 5181.0 5447.7 5768.6 5799.8 5108.3 5115.4 5305.4 5502.5 5531.0 5116.8 5137.9 5292.4 5358.5 5417.6 5176.8 5260.0 5805.6 6041.9 6157.3 3920.7 3925.7 3945.6 3947.4 3953.8 4958.1 5467.9 5638.0 5764.6 5777.3 4638.4 4865.6 5175.9 5253.8 5715.8 5179.6 5486.9 5689.9 5705.7 5706.9 5260.3 5467.4 5469.4 5570.2 5584.3 4825.4 5387.4 5651.7 5651.9 5702.2 5569.8 5570.4 5599.2 5611.2 5626.6 07:25:30 INFO - PROCESS | 1973 | 07:25:30 INFO - PROCESS | 1973 | [#5] yui.html Cycles:180 Average:20721.86 Median:4290.28 stddev:30045.92 (700.3%) stddev-sans-first:30092.65 07:25:30 INFO - PROCESS | 1973 | Values: 715.6 777.6 793.3 810.9 839.8 15489.3 16119.4 16132.9 16195.9 16220.2 14913.6 15016.2 15022.2 15061.6 15079.0 683.6 702.5 848.4 850.6 869.8 866.3 875.6 876.9 877.0 878.0 759.7 906.1 932.9 935.9 936.1 915.5 925.8 930.2 930.6 931.7 692.0 692.2 694.7 695.4 695.7 13334.8 15328.8 15576.4 15637.3 16011.7 14500.4 14592.3 14670.5 14828.8 14940.3 11851.3 11898.3 11968.3 12040.1 12055.0 3724.7 3754.3 3775.1 3797.2 3909.3 88656.2 89818.0 106390.0 107441.5 108842.5 9764.0 11319.9 11688.7 11760.2 11892.7 23841.8 24248.5 24291.9 24294.8 24344.8 6644.0 7688.1 7743.3 7889.7 7893.1 3675.7 4241.6 4338.9 4377.3 4434.2 3608.5 3704.8 3711.6 3715.6 3725.7 563.5 659.2 660.8 669.2 677.6 679.8 684.8 699.8 713.7 724.5 8699.8 10310.5 10458.4 10527.8 10641.4 554.4 559.8 584.8 595.2 595.8 4234.8 5039.7 5080.4 5106.9 5117.6 103390.5 105424.5 106510.0 108438.0 111097.0 82422.6 87471.1 89497.0 93410.5 94167.0 82429.6 84177.2 84773.6 84781.0 85435.1 9692.5 9811.4 9817.7 9906.4 9945.3 52093.7 52898.0 53624.0 54241.7 55924.0 61619.0 73411.9 73596.0 73933.0 74909.6 10057.3 12002.5 12212.5 12282.9 12636.2 12767.2 12995.6 13076.0 13155.5 13292.8 9783.9 11484.2 11526.7 11802.8 12355.8 10541.5 11130.4 11271.0 12183.4 12691.9 11903.1 11909.4 11991.2 12135.8 12294.4 9839.3 10466.1 10653.6 10714.7 11050.2 9428.5 10049.6 10071.1 10096.9 10118.3 07:25:30 INFO - PROCESS | 1973 | -------- Summary: end -------- 07:25:30 INFO - PROCESS | 1973 | 07:25:31 INFO - TEST-INFO | 1973: exit 0 07:25:31 INFO - TEST-OK | dromaeo_css | took 1115180ms 07:25:31 INFO - TEST-START | kraken 07:25:31 INFO - operating with platform_type : mac_ 07:25:31 INFO - Initialising browser for kraken test... 07:25:31 INFO - TEST-INFO | started process 1979 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/tmpYfWWk6/profile http://localhost:49667/getInfo.html) 07:25:34 INFO - PROCESS | 1979 | 2017-01-18 07:25:34.088 plugin-container[1980:16722] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x434b, name = 'com.apple.tsm.portname' 07:25:34 INFO - PROCESS | 1979 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:25:34 INFO - PROCESS | 1979 | 2017-01-18 07:25:34.091 plugin-container[1980:16722] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 07:25:34 INFO - PROCESS | 1979 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:25:34 INFO - PROCESS | 1979 | 2017-01-18 07:25:34.091 plugin-container[1980:16722] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:25:34 INFO - PROCESS | 1979 | __metrics Screen width/height:1600/1200 07:25:34 INFO - PROCESS | 1979 | colorDepth:24 07:25:34 INFO - PROCESS | 1979 | Browser inner width/height: 1024/689 07:25:34 INFO - PROCESS | 1979 | __metrics 07:25:34 ERROR - PROCESS | 1979 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3253: TypeError: this.tabs is undefined 07:25:35 INFO - TEST-INFO | 1979: exit 0 07:25:35 INFO - Browser initialized. 07:25:35 INFO - Running cycle 1/1 for kraken test... 07:25:35 INFO - TEST-INFO | started process 1981 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/tmpYfWWk6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:25:37 INFO - PROCESS | 1981 | 2017-01-18 07:25:37.604 plugin-container[1982:16839] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x873f, name = 'com.apple.tsm.portname' 07:25:37 INFO - PROCESS | 1981 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:25:37 INFO - PROCESS | 1981 | 2017-01-18 07:25:37.605 plugin-container[1982:16839] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4623, name = 'com.apple.CFPasteboardClient' 07:25:37 INFO - PROCESS | 1981 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:25:37 INFO - PROCESS | 1981 | 2017-01-18 07:25:37.605 plugin-container[1982:16839] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:25:47 INFO - PROCESS | 1981 | RSS: Main: 234016768 07:25:47 INFO - PROCESS | 1981 | 07:25:50 INFO - PROCESS | 1981 | Cycle 1(1): loaded http://localhost:49667/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49667/tests/kraken/driver.html?testName=audio-beat-detection) 07:25:51 INFO - PROCESS | 1981 | RSS: Main: 246693888 07:25:51 INFO - PROCESS | 1981 | 07:25:54 INFO - PROCESS | 1981 | Cycle 1(1): loaded http://localhost:49667/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49667/tests/kraken/driver.html?testName=audio-dft) 07:25:54 INFO - PROCESS | 1981 | RSS: Main: 254304256 07:25:54 INFO - PROCESS | 1981 | 07:25:58 INFO - PROCESS | 1981 | Cycle 1(1): loaded http://localhost:49667/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49667/tests/kraken/driver.html?testName=audio-fft) 07:25:58 INFO - PROCESS | 1981 | RSS: Main: 257122304 07:25:58 INFO - PROCESS | 1981 | 07:26:00 INFO - PROCESS | 1981 | Cycle 1(1): loaded http://localhost:49667/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49667/tests/kraken/driver.html?testName=audio-oscillator) 07:26:01 INFO - PROCESS | 1981 | RSS: Main: 259280896 07:26:01 INFO - PROCESS | 1981 | 07:26:03 INFO - PROCESS | 1981 | Cycle 1(1): loaded http://localhost:49667/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49667/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:26:04 INFO - PROCESS | 1981 | RSS: Main: 259551232 07:26:04 INFO - PROCESS | 1981 | 07:26:06 INFO - PROCESS | 1981 | Cycle 1(1): loaded http://localhost:49667/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49667/tests/kraken/driver.html?testName=imaging-darkroom) 07:26:07 INFO - PROCESS | 1981 | RSS: Main: 265900032 07:26:07 INFO - PROCESS | 1981 | 07:26:10 INFO - PROCESS | 1981 | Cycle 1(1): loaded http://localhost:49667/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49667/tests/kraken/driver.html?testName=imaging-desaturate) 07:26:11 INFO - PROCESS | 1981 | RSS: Main: 264822784 07:26:11 INFO - PROCESS | 1981 | 07:26:14 INFO - PROCESS | 1981 | Cycle 1(1): loaded http://localhost:49667/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49667/tests/kraken/driver.html?testName=json-parse-financial) 07:26:14 INFO - PROCESS | 1981 | RSS: Main: 264867840 07:26:14 INFO - PROCESS | 1981 | 07:26:16 INFO - PROCESS | 1981 | Cycle 1(1): loaded http://localhost:49667/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49667/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:26:17 INFO - PROCESS | 1981 | RSS: Main: 264077312 07:26:17 INFO - PROCESS | 1981 | 07:26:19 INFO - PROCESS | 1981 | Cycle 1(1): loaded http://localhost:49667/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49667/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:26:20 INFO - PROCESS | 1981 | RSS: Main: 264052736 07:26:20 INFO - PROCESS | 1981 | 07:26:22 INFO - PROCESS | 1981 | Cycle 1(1): loaded http://localhost:49667/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49667/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:26:22 INFO - PROCESS | 1981 | RSS: Main: 264151040 07:26:22 INFO - PROCESS | 1981 | 07:26:25 INFO - PROCESS | 1981 | Cycle 1(1): loaded http://localhost:49667/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49667/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:26:26 INFO - PROCESS | 1981 | RSS: Main: 264445952 07:26:26 INFO - PROCESS | 1981 | 07:26:29 INFO - PROCESS | 1981 | Cycle 1(1): loaded http://localhost:49667/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49667/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:26:30 INFO - PROCESS | 1981 | RSS: Main: 264265728 07:26:30 INFO - PROCESS | 1981 | 07:26:32 INFO - PROCESS | 1981 | Cycle 1(1): loaded http://localhost:49667/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49667/tests/kraken/driver.html?testName=ai-astar) 07:26:32 INFO - PROCESS | 1981 | RSS: Main: 266244096 07:26:32 INFO - PROCESS | 1981 | 07:26:32 INFO - PROCESS | 1981 | __start_tp_report 07:26:32 INFO - PROCESS | 1981 | _x_x_mozilla_page_load 07:26:32 INFO - PROCESS | 1981 | _x_x_mozilla_page_load_details 07:26:32 INFO - PROCESS | 1981 | |i|pagename|runs| 07:26:32 INFO - PROCESS | 1981 | |0;ai-astar;122;173;123;119;119;121;120;118;136;119 07:26:32 INFO - PROCESS | 1981 | |1;audio-beat-detection;144;123;142;183;102;140;142;144;130;114 07:26:32 INFO - PROCESS | 1981 | |2;audio-dft;209;250;276;198;197;203;198;193;201;198 07:26:32 INFO - PROCESS | 1981 | |3;audio-fft;86;58;60;87;61;65;60;63;73;60 07:26:32 INFO - PROCESS | 1981 | |4;audio-oscillator;92;67;84;70;62;72;82;70;71;84 07:26:32 INFO - PROCESS | 1981 | |5;imaging-gaussian-blur;93;89;91;89;92;86;91;97;137;132 07:26:32 INFO - PROCESS | 1981 | |6;imaging-darkroom;98;99;98;96;96;97;95;115;152;107 07:26:32 INFO - PROCESS | 1981 | |7;imaging-desaturate;100;94;92;89;94;100;148;144;79;147 07:26:32 INFO - PROCESS | 1981 | |8;json-parse-financial;64;62;61;62;66;78;78;91;92;90 07:26:32 INFO - PROCESS | 1981 | |9;json-stringify-tinderbox;69;110;100;74;84;74;60;62;96;106 07:26:32 INFO - PROCESS | 1981 | |10;stanford-crypto-aes;89;92;79;80;83;109;111;111;111;86 07:26:32 INFO - PROCESS | 1981 | |11;stanford-crypto-ccm;139;145;154;147;151;149;144;148;205;140 07:26:32 INFO - PROCESS | 1981 | |12;stanford-crypto-pbkdf2;176;176;174;183;180;175;176;176;186;177 07:26:32 INFO - PROCESS | 1981 | |13;stanford-crypto-sha256-iterative;68;69;70;68;71;67;67;68;66;68 07:26:32 INFO - PROCESS | 1981 | __end_tp_report 07:26:32 INFO - PROCESS | 1981 | __start_cc_report 07:26:32 INFO - PROCESS | 1981 | _x_x_mozilla_cycle_collect,925 07:26:32 INFO - PROCESS | 1981 | __end_cc_report 07:26:32 INFO - PROCESS | 1981 | __startTimestamp1484753192281__endTimestamp 07:26:32 INFO - PROCESS | 1981 | 07:26:32 INFO - PROCESS | 1981 | ------- Summary: start ------- 07:26:32 INFO - PROCESS | 1981 | Number of tests: 14 07:26:32 INFO - PROCESS | 1981 | 07:26:32 INFO - PROCESS | 1981 | [#0] ai-astar Cycles:10 Average:127.00 Median:121.50 stddev:16.98 (14.0%) stddev-sans-first:17.92 07:26:32 INFO - PROCESS | 1981 | Values: 122.0 173.0 123.0 119.0 119.0 121.0 120.0 118.0 136.0 119.0 07:26:32 INFO - PROCESS | 1981 | 07:26:32 INFO - PROCESS | 1981 | [#1] audio-beat-detection Cycles:10 Average:136.40 Median:142.00 stddev:21.78 (15.3%) stddev-sans-first:22.92 07:26:32 INFO - PROCESS | 1981 | Values: 144.0 123.0 142.0 183.0 102.0 140.0 142.0 144.0 130.0 114.0 07:26:32 INFO - PROCESS | 1981 | 07:26:32 INFO - PROCESS | 1981 | [#2] audio-dft Cycles:10 Average:212.30 Median:202.00 stddev:27.74 (13.7%) stddev-sans-first:29.39 07:26:32 INFO - PROCESS | 1981 | Values: 209.0 250.0 276.0 198.0 197.0 203.0 198.0 193.0 201.0 198.0 07:26:32 INFO - PROCESS | 1981 | 07:26:32 INFO - PROCESS | 1981 | [#3] audio-fft Cycles:10 Average:67.30 Median:64.00 stddev:10.95 (17.1%) stddev-sans-first:9.30 07:26:32 INFO - PROCESS | 1981 | Values: 86.0 58.0 60.0 87.0 61.0 65.0 60.0 63.0 73.0 60.0 07:26:32 INFO - PROCESS | 1981 | 07:26:32 INFO - PROCESS | 1981 | [#4] audio-oscillator Cycles:10 Average:75.40 Median:77.00 stddev:9.47 (12.3%) stddev-sans-first:7.91 07:26:32 INFO - PROCESS | 1981 | Values: 92.0 67.0 84.0 70.0 62.0 72.0 82.0 70.0 71.0 84.0 07:26:32 INFO - PROCESS | 1981 | 07:26:32 INFO - PROCESS | 1981 | [#5] imaging-gaussian-blur Cycles:10 Average:99.70 Median:91.00 stddev:18.60 (20.4%) stddev-sans-first:19.57 07:26:32 INFO - PROCESS | 1981 | Values: 93.0 89.0 91.0 89.0 92.0 86.0 91.0 97.0 137.0 132.0 07:26:32 INFO - PROCESS | 1981 | 07:26:32 INFO - PROCESS | 1981 | [#6] imaging-darkroom Cycles:10 Average:105.30 Median:96.50 stddev:17.55 (18.2%) stddev-sans-first:18.41 07:26:32 INFO - PROCESS | 1981 | Values: 98.0 99.0 98.0 96.0 96.0 97.0 95.0 115.0 152.0 107.0 07:26:32 INFO - PROCESS | 1981 | 07:26:32 INFO - PROCESS | 1981 | [#7] imaging-desaturate Cycles:10 Average:108.70 Median:84.00 stddev:26.65 (31.7%) stddev-sans-first:28.08 07:26:32 INFO - PROCESS | 1981 | Values: 100.0 94.0 92.0 89.0 94.0 100.0 148.0 144.0 79.0 147.0 07:26:32 INFO - PROCESS | 1981 | 07:26:32 INFO - PROCESS | 1981 | [#8] json-parse-financial Cycles:10 Average:74.40 Median:78.00 stddev:13.00 (16.7%) stddev-sans-first:13.23 07:26:32 INFO - PROCESS | 1981 | Values: 64.0 62.0 61.0 62.0 66.0 78.0 78.0 91.0 92.0 90.0 07:26:32 INFO - PROCESS | 1981 | 07:26:32 INFO - PROCESS | 1981 | [#9] json-stringify-tinderbox Cycles:10 Average:83.50 Median:71.50 stddev:18.39 (25.7%) stddev-sans-first:18.74 07:26:32 INFO - PROCESS | 1981 | Values: 69.0 110.0 100.0 74.0 84.0 74.0 60.0 62.0 96.0 106.0 07:26:32 INFO - PROCESS | 1981 | 07:26:32 INFO - PROCESS | 1981 | [#10] stanford-crypto-aes Cycles:10 Average:95.10 Median:81.50 stddev:13.80 (16.9%) stddev-sans-first:14.46 07:26:32 INFO - PROCESS | 1981 | Values: 89.0 92.0 79.0 80.0 83.0 109.0 111.0 111.0 111.0 86.0 07:26:32 INFO - PROCESS | 1981 | 07:26:32 INFO - PROCESS | 1981 | [#11] stanford-crypto-ccm Cycles:10 Average:152.20 Median:148.50 stddev:19.12 (12.9%) stddev-sans-first:19.67 07:26:32 INFO - PROCESS | 1981 | Values: 139.0 145.0 154.0 147.0 151.0 149.0 144.0 148.0 205.0 140.0 07:26:32 INFO - PROCESS | 1981 | 07:26:32 INFO - PROCESS | 1981 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.90 Median:176.50 stddev:3.87 (2.2%) stddev-sans-first:4.04 07:26:32 INFO - PROCESS | 1981 | Values: 176.0 176.0 174.0 183.0 180.0 175.0 176.0 176.0 186.0 177.0 07:26:32 INFO - PROCESS | 1981 | 07:26:32 INFO - PROCESS | 1981 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:68.00 stddev:1.48 (2.2%) stddev-sans-first:1.56 07:26:32 INFO - PROCESS | 1981 | Values: 68.0 69.0 70.0 68.0 71.0 67.0 67.0 68.0 66.0 68.0 07:26:32 INFO - PROCESS | 1981 | -------- Summary: end -------- 07:26:32 INFO - PROCESS | 1981 | 07:26:33 INFO - TEST-INFO | 1981: exit 0 07:26:33 INFO - TEST-OK | kraken | took 61836ms 07:26:33 INFO - SUITE-END | took 1177s 07:26:33 INFO - Completed test suite (00:19:37) 07:26:33 INFO - javascript benchmark 07:26:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7166.88976527185, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2842.687304396516, 3340.114869559567, 3384.2216290253227, 3396.269801992571, 3410.266792639583, 5518.420565840579, 5554.055810512213, 5575.581831362644, 5575.8606034849145, 5624.803131890385, 4522.728636281825, 5545.805896793613, 5558.610897237195, 5594.13290939904, 5595.1886976388505, 3881.592432794558, 5082.872928176788, 5109.744512774365, 5214.296070030554, 5216.139337009389, 5041.949580504203, 5210.088234558956, 5234.18870075139, 5251.606129540281, 5274.0, 5056.469070747556, 5073.518015788494, 5170.741462926876, 5176.430592634807, 5185.55922746567, 5059.16523773577, 5134.743262836881, 5187.48125187482, 5209.01028804526, 5245.921311180336, 5085.898282034375, 5088.745562721849, 5117.513836185593, 5141.76862041209, 5142.691438513663, 4369.584889435499, 5589.217509548666, 5641.802536911188, 5647.519960803336, 5653.378128405913, 6089.908651370233, 6100.847478813021, 6106.157323464386, 6111.87776244477, 6134.405972711579, 6207.875842483125, 6289.7169627366875, 6290.559660823744, 6293.0, 6301.6534090625, 5785.855353616151, 5799.623024503394, 5802.0426629605645, 5822.621529600562, 5841.883162336772, 5984.31180414258, 6221.097940798559, 6228.0, 6296.118543403927, 6309.968450157719, 5127.179651255781, 5988.760449582055, 6014.729337179838, 6092.39076092396, 6103.938960610426, 6243.032329988859, 6243.96878015607, 6270.059491076284, 6282.591631543935, 6302.432781049728, 6062.090686396988, 6114.11345354921, 6131.957816600026, 6213.844653883599, 6247.312795592481, 6016.217891674142, 6240.5319601030105, 6245.313015568284, 6245.531585131133, 6267.71795269214, 4859.392575928009, 4883.731394773251, 4894.681845680019, 4898.8775280618265, 4924.162892308316, 4382.758948257812, 4389.539098394686, 4406.889827754268, 4421.447319085114, 4458.665600080007, 4811.542903424169, 4811.831585894547, 5783.450572195635, 5814.360420353758, 5815.79644712433, 6108.251008765781, 6111.51107911366, 6183.628982261079, 6187.443130118221, 6220.253569571681, 5828.242328497268, 5874.236349274567, 5874.265716785402, 5948.899453601098, 5963.731632076567, 5003.324551185616, 5400.324959380077, 5405.135178371442, 5407.891842163213, 5420.701861397582, 6068.605540639845, 6233.96883015582, 6267.341929097379, 6301.527385446018, 6320.336364681734, 4504.684672072924, 5073.213651883964, 6114.449440885012, 6168.228971378578, 6282.874342513215, 6293.118963345227, 6306.4639505642535, 6315.810525684236, 6327.570700509754, 6370.044493326038, 6166.414190651881, 6166.660833654192, 6178.104174894705, 6181.907271390843, 6222.377762223922, 4578.9771051144535, 5598.740283436195, 6090.7148889660975, 6125.204929265209, 6214.5028397728975, 6027.75888964454, 6035.728392222272, 6107.206063211754, 6115.174451448997, 6132.325444201224, 5163.870903227299, 5959.106134079922, 6057.394260573908, 6066.4540191382985, 6080.027195648675, 5006.574441172541, 5550.583706221969, 5737.8524295140305, 5930.822075337746, 5987.550933680079, 6107.755689772537, 6110.877782444415, 6112.510999119971, 6113.174721412553, 6163.0, 5505.834824955257, 5636.2954630671165, 5879.0, 5940.108983652487, 5962.791302304398], "value": 5584.505238126719, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [424.40371278353916, 444.6353989728424, 465.030411591831, 471.2954133570313, 540.2652392745865, 38718.80640596797, 41384.37923431151, 41444.17111657765, 41601.79199104004, 41716.37425438621, 42671.78664106675, 43223.78388108063, 43235.56764432362, 43350.0, 44016.497937757784, 8137.593120343989, 9227.584758685858, 9483.95676475587, 10748.140148788078, 11052.171087168454, 10959.780804383907, 11106.222564420494, 11109.44452777362, 11113.944430277837, 11120.666380008613, 11111.833322500128, 11144.60993865215, 11144.944275278613, 11165.832512512277, 11175.552977880876, 11058.060064894493, 11104.44477776108, 11111.555537778479, 11132.833007504894, 11156.832647510293, 10770.4614769262, 10968.341899485977, 10973.177011724152, 10991.285566438157, 11008.339499629968, 36651.26697466036, 36990.815045924865, 37066.62933370686, 37150.814245928595, 37213.62786372129, 3897.629725176104, 3921.8235179416993, 3945.3687410014545, 3954.9321683145677, 4041.818118184689, 27697.584536231974, 28480.857595712096, 28680.569791453145, 28697.0, 28736.281592960135, 3137.7646676499353, 3244.935101297961, 3247.4966380211104, 3318.286568387808, 3324.667533246656, 405579.0, 472158.0, 479821.0, 480038.0, 481209.0, 55075.724621376634, 55254.0, 55263.723681381336, 55654.72172639111, 55829.44170558324, 55936.720316398154, 56423.15365269524, 56441.71779141078, 56444.0, 56552.717236413555, 14890.106593604418, 15316.0, 15320.310586023656, 15428.691426171414, 15446.304916278794, 10590.417527035934, 10871.402072886067, 11634.301941883514, 11906.52373905034, 11935.0, 15164.772528412082, 15884.046957182374, 16434.506964791075, 17715.73426398605, 17848.107594620476, 6571.9156339204455, 7678.232176782389, 7712.845743085107, 7768.184340644264, 7807.960960195162, 840.5797101449275, 843.932425481766, 866.1814585217036, 867.5878957495139, 883.7569668341257, 29133.12600621985, 29737.851310743306, 29969.0, 30178.09465716032, 30553.38893222123, 959.9904000959901, 1038.2161468091695, 1047.7694907120422, 1082.231615552966, 1176.0591526778544, 15723.528294151194, 15742.68514629701, 15762.842371576138, 15775.211239437982, 16036.438724644815, 656640.0, 661110.0, 661291.0, 661836.0, 663480.0, 46913.0, 47270.32756069225, 47387.289190662166, 47538.81152971203, 47572.5242747575, 1401.0332870319446, 1441.9206943617992, 1462.8098347215007, 1463.4219483304034, 1464.392277204948, 25660.358491037874, 26241.81911813935, 29650.555241671824, 30244.697553025067, 30736.385272294876, 50991.2351314738, 51374.22938655849, 51396.0, 51558.74220628873, 51571.484285156665, 557556.0, 561730.0, 562798.0, 563061.0, 563536.0, 25493.0, 26424.471510570067, 26450.735492644828, 26492.94028238849, 26556.601650974866, 47130.764346178046, 47250.0, 48286.75856620695, 48427.03145937132, 48545.0, 38523.0, 38552.614473854905, 39036.609633903296, 39963.60036399599, 40345.79827100963, 38101.0, 38286.042848929, 38556.42165367465, 39724.20551588894, 39770.80114599524, 37622.62377376191, 38476.615233847304, 38502.42246366363, 38557.807210963765, 38644.227115458096, 27291.044813431436, 30007.549886752153, 32616.673833261364, 34107.488387674704, 34348.82825585856, 21320.893395532923, 24715.50568988646, 25040.62439063452, 25603.6159457612, 25605.871970640772], "value": 19800.02457857729, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.9962500374997, 375.90790256387186, 386.39336242099904, 389.25069241709735, 405.4971834924692, 18651.1606977686, 19125.426237212872, 20941.581168376622, 21157.942102894853, 21185.258515951944, 11844.230125041888, 12028.037756979442, 12219.266843989366, 12235.571754988578, 12248.877511224886, 5068.873278168038, 5373.328333958255, 5382.730863456831, 5389.191621256804, 5391.595630327722, 3930.351492003816, 4143.937840932388, 4487.326900964865, 5320.787168513255, 6117.021276595746, 6136.7545298188015, 6144.44699977002, 6145.569810113294, 6153.369357120367, 6158.907616385758, 6035.758569657209, 6545.083688283644, 6620.503462240351, 6626.7017984190825, 6647.069410282588, 4971.751412429364, 5625.324961004665, 5854.20968169296, 5887.8528036799, 5893.791772686589, 12794.0, 13169.670758231025, 20417.5916481671, 20566.897165514227, 25607.359816004562, 2598.1296265751, 2815.53543665295, 2925.3710452252867, 2935.765138788892, 2936.4420760055737, 10164.695059148238, 10178.9491052545, 10217.029382208679, 10585.04734573892, 10585.894141058568, 1834.0279651784576, 1893.9242430302909, 1905.90470476477, 1912.6174765047047, 1912.8278454939123, 113104.0, 135490.0, 138870.3056484711, 141290.5870941298, 141944.58055419417, 9241.953790231006, 9645.662401815904, 11258.155638327158, 11712.88287117135, 11916.285022898654, 13641.522546710818, 14814.777778333333, 15171.468998584996, 15482.071075735492, 15487.457938972082, 8478.830423391497, 8681.175288347597, 8714.0, 8717.12828717136, 8758.036615972238, 8354.707585234488, 8432.45189062709, 8470.534120623424, 8568.143185681382, 8612.698555550525, 3875.457435958968, 4720.12677654635, 4728.574428301469, 4779.187538118528, 4787.234042553175, 1665.1424516374077, 1747.6242607839122, 1755.9034253116201, 1992.4221975627195, 2042.0, 905.4160066757037, 994.1450352696675, 994.3834822410151, 1011.1607365886443, 1019.4342140112309, 18171.727979041603, 20102.0, 21367.57264854725, 21771.891140544514, 21891.0, 1028.8199565076081, 1031.5409642709074, 1050.9842352364722, 1076.1229597877705, 1077.7359546911057, 10937.617183398543, 11712.531498740125, 11746.119041071783, 11768.35274059935, 11779.411029448493, 672800.0, 740588.0, 742346.0, 742905.0, 769969.0, 105161.0, 123829.0, 152086.0, 153033.46966530193, 156008.0, 1012.2408193854609, 1029.6190409548515, 1050.1703654113164, 1052.1267348101057, 1055.994720026395, 18994.810051899858, 19079.904600476908, 19128.617427651647, 19235.90382048081, 19370.903145484746, 57879.71060144672, 57915.0, 59740.70129649324, 60573.69713151406, 60731.48171295753, 84172.57913710392, 84225.15774842173, 84891.15108849079, 85441.29117417742, 86933.0, 7412.518186317872, 7672.002639656809, 8171.142030086755, 8315.667373305, 8434.650455927022, 10285.640002599874, 12758.362081896053, 12800.423980920694, 13166.736665266833, 13620.591382258548, 10653.254272200871, 11031.338119712844, 11087.55649774, 11202.103831693608, 11231.045361144394, 10635.94682026585, 11002.889971100187, 11259.380734059705, 11290.018739031757, 11415.258008229439, 9632.532288376038, 11021.173411994292, 11393.772124557629, 11494.252873563191, 11749.0, 6682.899756503559, 6916.170059592881, 7181.210066892742, 7310.232425595236, 8581.97016358041, 7175.641217939186, 7868.921310786819, 8413.537255451009, 9942.0, 10657.733556661145], "value": 9516.32493128627, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1404.8103506026682, 1432.8710416062556, 1451.7677171652524, 1480.9337277160448, 1495.678429137735, 6376.713047912844, 7815.218478152182, 8095.514269143848, 8550.230479256858, 8583.18459746324, 7957.960210198956, 8265.504069755803, 8281.91718082819, 8376.45553039052, 8406.831863362744, 1936.786953435128, 2268.27415227127, 2307.2040146149634, 2318.8869342715507, 2322.8722420266877, 2298.390926404504, 2324.895379707917, 2338.929832105031, 2340.4031971847157, 2351.988240058797, 2294.804941579968, 2309.618912879373, 2311.3297143828354, 2325.2442956039354, 2327.976720232793, 2280.566692328452, 2285.1430713482446, 2306.5848147333472, 2308.653701944705, 2312.6184179610345, 1881.369741136721, 2334.7548507406646, 2335.404471859665, 2342.730585982617, 2349.3539276698875, 8417.873731894026, 8444.915550844475, 8463.788405289855, 8488.915110848875, 8493.787655308604, 5019.19692849146, 5187.351581052369, 5192.688438693691, 5199.376074871002, 5201.817936372247, 3273.8363081845814, 3337.8998630041137, 3455.58532976042, 3504.8072356020407, 3550.55618047744, 1198.1253684810051, 1206.4329765010432, 1214.3563911127117, 1230.6308107567693, 1243.8258643789877, 10630.78738425235, 10700.892991070068, 10721.249512534127, 10765.246432749711, 10782.353058816496, 4394.406755088022, 4619.2609182531305, 4687.109449204709, 4697.271922851964, 4707.552782485658, 9462.29032822541, 9509.096635819586, 9517.428954262767, 9521.000294968928, 9544.952275238718, 5212.0, 5242.18746094356, 5254.789808407697, 5256.0, 5259.658122222043, 4165.854195103157, 4672.672912896064, 4695.060987802453, 4726.9600687848615, 4806.423229212517, 3781.5273090863643, 3815.923681526354, 3865.980670096688, 3903.863364782219, 3928.253631809947, 1162.4071723420948, 1266.202292555684, 1269.136986848933, 1274.9808752868714, 1275.101053757099, 756.8334966307403, 761.497411708281, 849.3290300662532, 867.2021739999216, 868.9391742577959, 4141.378793181047, 4852.441969173519, 4860.854174374775, 5252.684838909678, 5360.927814437128, 507.70517261976397, 554.972251387429, 558.1906235957878, 561.3376216065083, 569.4021277658442, 2883.7548808351107, 3417.6582341765625, 3477.2523907360037, 3477.51314815926, 3583.33708263972, 9048.592813323416, 9689.467079310565, 9981.351212171186, 10069.949650251701, 10074.546645400975, 8260.29787468072, 9167.0, 9969.202463802878, 10012.69961901144, 10031.297809153435, 5998.310194327621, 7568.940348351235, 7835.84328313442, 7856.45004849655, 7861.960690196513, 5018.874528136826, 5108.923366149436, 5140.357455318085, 5171.663841850268, 5283.498067683564, 7046.506744528039, 9058.456492610465, 9117.179453849185, 9196.58615362297, 9314.906850931675, 9113.316501262565, 9122.407043542149, 9232.261419086592, 9353.0, 9355.766105847408, 5775.826725198251, 6592.110065141144, 6794.335387830013, 6989.5107342485535, 7215.819604509929, 6376.521760868046, 7836.568988705676, 7979.241972012649, 7993.280604745601, 8029.237222463857, 7033.085698859116, 7201.747938822116, 7203.171635261802, 7241.0, 7299.5620262784405, 7032.331928466788, 7241.203467618452, 7334.339909408179, 7376.4098872089035, 7448.329650331496, 5475.890482190413, 6296.307406185408, 6310.6213627182515, 6415.133956915756, 6420.550561460653, 4689.601383882272, 4813.831515896927, 4852.296417019583, 4879.682820616648, 4894.632902532396, 4564.863054108382, 4793.5685788279225, 4821.807127714992, 4907.705537667752, 4941.209406494943], "value": 4266.915852704386, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.83953381444536, 352.21631869091266, 362.26098758532595, 362.67540551206656, 366.6773239549198, 4291.42065821114, 4450.71070380425, 4590.42619672541, 5221.373435187773, 5459.563234941205, 4416.779161041943, 5090.338256026721, 5247.055530004598, 5273.419923808378, 5307.708076055825, 4152.231837110129, 4155.210510003105, 4166.937495937564, 4169.249535083683, 4189.706720529564, 4032.2338755636483, 4083.448734420845, 4176.786303259278, 4183.556672947828, 4212.304969679999, 4056.3369018702338, 4100.671946244293, 4103.548609652936, 4116.217918595472, 4140.648044916185, 3448.189675426273, 3579.49887015818, 3999.98000509871, 4087.795610219492, 4111.773852438099, 2861.5978170696417, 3388.8816690492076, 3625.8912232633065, 3678.797666128362, 3684.1894783147663, 4304.096139810644, 4792.880177995543, 4806.2937657131915, 5154.969006198775, 5199.2184181462735, 3905.4922860028014, 4445.955540444619, 4598.310253461974, 4603.089717767122, 4622.342153261888, 4783.727729328576, 5093.567046801027, 5309.867253318659, 5674.354437213203, 5680.971595142039, 3409.3010932758725, 3565.6612621800887, 3700.3154416433044, 3827.6937844972335, 3849.4225866120028, 4970.577500912426, 5462.726863656841, 5946.791862284799, 5981.58128930975, 5991.161237426763, 3668.779873207616, 3886.4753258310334, 3931.66580840626, 3949.0, 3960.3663413853646, 3512.666296701809, 3738.925221495609, 3956.3669812830385, 3973.1259122992897, 3994.400839874042, 4326.848560300375, 4379.861236078579, 4560.5895469407915, 4583.335416364608, 4606.378138951199, 5179.792808287626, 5333.306670132858, 5673.404292549306, 5694.9430505695245, 5704.976362527784, 1172.0447835014436, 1211.981820272679, 1227.2820400065882, 1258.4714419943462, 1367.4256812138926, 811.8213992921548, 856.7986523167051, 983.6016413352604, 988.1896844587369, 991.4200192887241, 4291.2061268664775, 4458.643308535309, 4591.770411479412, 5077.289179514871, 5116.462771409023, 4727.716337019721, 4967.875803104879, 5295.629305948547, 5377.623566350396, 5524.696141712164, 4419.337099435111, 4856.83001094967, 5068.366454193226, 5088.313077734532, 5091.439941606421, 2879.3941482957957, 2891.6530016397746, 2900.8984685535906, 2906.4768341698273, 2908.4473949949443, 5394.136938089887, 5479.972600137054, 5580.010292640782, 5610.719464026783, 5768.538516918637, 4728.976355118202, 4803.663743537989, 5033.697978121251, 5317.521423071942, 5724.912266669319, 4917.0, 5180.9740951295, 5447.68473398804, 5768.596198266081, 5799.7521388022, 5108.3103780989095, 5115.4373018967135, 5305.416404195458, 5502.532284755681, 5531.0, 5116.846494605168, 5137.897242055213, 5292.3649162099255, 5358.544523715528, 5417.593680473901, 5176.767045483038, 5259.973700131475, 5805.622634528742, 6041.909371359521, 6157.261128664589, 3920.686345092443, 3925.7448265862627, 3945.5659877412886, 3947.427622994592, 3953.822078006554, 4958.132326842716, 5467.917981230365, 5638.0, 5764.596478246483, 5777.335606405317, 4638.397008388888, 4865.635077369141, 5175.852021411072, 5253.816116435906, 5715.828525144252, 5179.633238395073, 5486.875190585841, 5689.943100569107, 5705.657660540381, 5706.859927527177, 5260.263563101093, 5467.425920278472, 5469.371022332482, 5570.2480165177185, 5584.3143525274745, 4825.372701548777, 5387.3804512481565, 5651.660900345993, 5651.858703532444, 5702.173184888251, 5569.8024924641395, 5570.442955704397, 5599.160125980972, 5611.156357894855, 5626.606137570331], "value": 4048.8803412073626, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [715.5849607227808, 777.5567926282018, 793.3335997761878, 810.9351251899849, 839.7774589733722, 15489.302981365838, 16119.435819746312, 16132.919335403307, 16195.947263427885, 16220.188990550485, 14913.627159321022, 15016.249187540634, 15022.173780442072, 15061.62345941352, 15079.0, 683.5898460923456, 702.5082442290417, 848.367965865428, 850.6044689219497, 869.821686554258, 866.3242670716851, 875.6016012714232, 876.9429987050853, 876.9561521923911, 878.0341624213346, 759.7151068349369, 906.0893801729253, 932.8507438809792, 935.8596210568401, 936.1060187520935, 915.5468043318533, 925.7778133248006, 930.1535602601667, 930.646354385336, 931.6878845586737, 691.9619420931847, 692.2143367278176, 694.697806454194, 695.4123765418213, 695.6730336741774, 13334.799978000337, 15328.846711532853, 15576.376944922189, 15637.296321665439, 16011.679766404606, 14500.41998320066, 14592.270386480634, 14670.486532971296, 14828.777568336483, 14940.32768525419, 11851.348175850324, 11898.345590992492, 11968.34174120423, 12040.096992725581, 12055.0, 3724.683401910841, 3754.342989976743, 3775.0562359410146, 3797.2215695782575, 3909.3158697228155, 88656.22687546213, 89818.0, 106390.0, 107441.46279268553, 108842.45578772055, 9763.999999999858, 11319.943400282946, 11688.70778230534, 11760.176787624785, 11892.702682433008, 23841.761582383955, 24248.51502969931, 24291.906864191154, 24294.75705242925, 24344.756552434603, 6644.0, 7688.115866675404, 7743.264389882952, 7889.723859664884, 7893.092294386104, 3675.6691897729334, 4241.63946064588, 4338.913221735547, 4377.277749171415, 4434.17967675981, 3608.4767708682093, 3704.759190652599, 3711.628837116267, 3715.64701353371, 3725.701943844486, 563.5092889428735, 659.1826135591928, 660.7687309441657, 669.2370697404962, 677.6239187251123, 679.8232459560451, 684.8185230913812, 699.800556841308, 713.7038129176334, 724.4747558020393, 8699.782505437415, 10310.484475776331, 10458.424786636655, 10527.84208236877, 10641.361518308771, 554.3624831443872, 559.829252078112, 584.7748616782569, 595.2351228671137, 595.7780057793444, 4234.788260586958, 5039.658449687998, 5080.441151473335, 5106.897862042739, 5117.565006974449, 103390.48304758428, 105424.47287763665, 106510.0, 108438.0, 111097.0, 82422.58788706017, 87471.1252887463, 89497.0, 93410.53294733482, 94167.0, 82429.58785206036, 84177.15822841816, 84773.57613211895, 84781.0, 85435.14564854396, 9692.515374231401, 9811.362261452983, 9817.656382026595, 9906.356086854332, 9945.30382873192, 52093.739531302104, 52898.0, 53624.0, 54241.72879135579, 55924.0, 61619.0, 73411.89882151665, 73596.0, 73933.0, 74909.62545187457, 10057.346272492265, 12002.519899203933, 12212.450439730055, 12282.877171228174, 12636.2418254905, 12767.233965962072, 12995.610131696065, 13076.0, 13155.53955611549, 13292.800607990694, 9783.853242201514, 11484.19610627248, 11526.732059473283, 11802.76394472123, 12355.75288494207, 10541.525631346454, 11130.387828669502, 11271.041961433042, 12183.390830458618, 12691.93654031724, 11903.107266955187, 11909.404529773303, 11991.243354331233, 12135.757284854077, 12294.385280736105, 9839.311248212556, 10466.058054775107, 10653.57385704563, 10714.678559643224, 11050.226484146033, 9428.528573571431, 10049.598016079568, 10071.093601575893, 10096.949515252376, 10118.291719579558], "value": 7453.608553868516, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1583.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 173.0, 123.0, 119.0, 119.0, 121.0, 120.0, 118.0, 136.0, 119.0], "value": 127.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 123.0, 142.0, 183.0, 102.0, 140.0, 142.0, 144.0, 130.0, 114.0], "value": 136.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [209.0, 250.0, 276.0, 198.0, 197.0, 203.0, 198.0, 193.0, 201.0, 198.0], "value": 212.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 58.0, 60.0, 87.0, 61.0, 65.0, 60.0, 63.0, 73.0, 60.0], "value": 67.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 67.0, 84.0, 70.0, 62.0, 72.0, 82.0, 70.0, 71.0, 84.0], "value": 75.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 89.0, 91.0, 89.0, 92.0, 86.0, 91.0, 97.0, 137.0, 132.0], "value": 99.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 99.0, 98.0, 96.0, 96.0, 97.0, 95.0, 115.0, 152.0, 107.0], "value": 105.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 94.0, 92.0, 89.0, 94.0, 100.0, 148.0, 144.0, 79.0, 147.0], "value": 108.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 61.0, 62.0, 66.0, 78.0, 78.0, 91.0, 92.0, 90.0], "value": 74.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 110.0, 100.0, 74.0, 84.0, 74.0, 60.0, 62.0, 96.0, 106.0], "value": 83.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 92.0, 79.0, 80.0, 83.0, 109.0, 111.0, 111.0, 111.0, 86.0], "value": 95.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 145.0, 154.0, 147.0, 151.0, 149.0, 144.0, 148.0, 205.0, 140.0], "value": 152.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 176.0, 174.0, 183.0, 180.0, 175.0, 176.0, 176.0, 186.0, 177.0], "value": 177.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 70.0, 68.0, 71.0, 67.0, 67.0, 68.0, 66.0, 68.0], "value": 68.2, "unit": "score"}]}]} 07:26:33 INFO - Return code: 0 07:26:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:26:33 ERROR - # TBPL SUCCESS # 07:26:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:26:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:26:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:26:33 INFO - 2017-01-18 07:26:33.626 screenresolution[1986:17220] starting screenresolution argv=screenresolution get 07:26:33 INFO - 2017-01-18 07:26:33.630 screenresolution[1986:17220] Display 0: 1600x1200x32@60 07:26:33 INFO - 2017-01-18 07:26:33.636 screenresolution[1987:17223] starting screenresolution argv=screenresolution list 07:26:33 INFO - Available Modes on Display 0 07:26:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:26:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:26:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:26:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:26:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:26:33 INFO - Intel Iris: 07:26:33 INFO - Chipset Model: Intel Iris 07:26:33 INFO - Type: GPU 07:26:33 INFO - Bus: Built-In 07:26:33 INFO - VRAM (Dynamic, Max): 1536 MB 07:26:33 INFO - Vendor: Intel (0x8086) 07:26:33 INFO - Device ID: 0x0a2e 07:26:33 INFO - Revision ID: 0x0009 07:26:33 INFO - Displays: 07:26:33 INFO - Display: 07:26:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:26:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:26:33 INFO - Display Serial Number: 1600x1200 60 07:26:33 INFO - Main Display: Yes 07:26:33 INFO - Mirror: Off 07:26:33 INFO - Online: Yes 07:26:33 INFO - Rotation: Supported 07:26:33 INFO - Return code: 0 07:26:33 INFO - Running post-action listener: _resource_record_post_action 07:26:33 INFO - [mozharness: 2017-01-18 15:26:33.881277Z] Finished run-tests step (success) 07:26:33 INFO - Running post-run listener: _resource_record_post_run 07:26:33 INFO - Total resource usage - Wall time: 1200s; CPU: 55.0%; Read bytes: 352256; Write bytes: 555235840; Read time: 5; Write time: 1707 07:26:33 INFO - TinderboxPrint: CPU usage
54.6% 07:26:33 INFO - TinderboxPrint: I/O read bytes / time
352,256 / 5 07:26:33 INFO - TinderboxPrint: I/O write bytes / time
555,235,840 / 1,707 07:26:33 INFO - TinderboxPrint: CPU idle
2,182.1 (45.4%) 07:26:33 INFO - TinderboxPrint: CPU system
973.8 (20.3%) 07:26:33 INFO - TinderboxPrint: CPU user
1,645.8 (34.3%) 07:26:33 INFO - TinderboxPrint: Swap in / out
252,575,744 / 0 07:26:33 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 237517312; Write bytes: 230133760; Read time: 17749; Write time: 495 07:26:33 INFO - run-tests - Wall time: 1178s; CPU: 55.0%; Read bytes: 352256; Write bytes: 299787264; Read time: 5; Write time: 1149 07:26:34 INFO - Running post-run listener: _upload_blobber_files 07:26:34 INFO - Blob upload gear active. 07:26:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:26:34 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 07:26:34 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', 'Graphics', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:26:34 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 Graphics -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:26:34 INFO - (blobuploader) - INFO - Open directory for files ... 07:26:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:26:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:26:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:26:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:26:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:26:35 INFO - (blobuploader) - INFO - Done attempting. 07:26:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:26:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:26:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:26:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:26:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:26:37 INFO - (blobuploader) - INFO - Done attempting. 07:26:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:26:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:26:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:26:38 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:26:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:26:38 INFO - (blobuploader) - INFO - Done attempting. 07:26:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:26:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:26:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:26:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:26:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:26:40 INFO - (blobuploader) - INFO - Done attempting. 07:26:40 INFO - (blobuploader) - INFO - Iteration through files over. 07:26:40 INFO - Return code: 0 07:26:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:26:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:26:40 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/7f67d8f3cbc3b38bd5802d4704d4bffd73147d2256a2e426559e6dad333a960ed8bcf3f24c31723115520a5cd11ae4bcafef91a8f56b9762bd874e2ff4a79fd1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/6e0b92704850c8eaa160b26a1a2e07c64190f389f5b76bfb6e47c7a0421add3bd16b727ef42c23bc4e892228bb6ebe1a22005d2c6f03a8a3fc4d1aee39d25487", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/228a75a01cb5e39ee03f23497bebd82d4990902e768644c05f764058b2a934d69aaff11f43bf0af4038d3014bb244d66940a1163b19f27cc34ef4d0543708e3b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/a079dcc330d960236c94a4b5a8a6f236297ffa532d06f198d94c067499316171814b6462cda60c58f389a516fd89baec9f5b59bbbd038566d3d43abd51d6f63b"} 07:26:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:26:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:26:40 INFO - Contents: 07:26:40 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/7f67d8f3cbc3b38bd5802d4704d4bffd73147d2256a2e426559e6dad333a960ed8bcf3f24c31723115520a5cd11ae4bcafef91a8f56b9762bd874e2ff4a79fd1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/6e0b92704850c8eaa160b26a1a2e07c64190f389f5b76bfb6e47c7a0421add3bd16b727ef42c23bc4e892228bb6ebe1a22005d2c6f03a8a3fc4d1aee39d25487", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/228a75a01cb5e39ee03f23497bebd82d4990902e768644c05f764058b2a934d69aaff11f43bf0af4038d3014bb244d66940a1163b19f27cc34ef4d0543708e3b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/a079dcc330d960236c94a4b5a8a6f236297ffa532d06f198d94c067499316171814b6462cda60c58f389a516fd89baec9f5b59bbbd038566d3d43abd51d6f63b"} 07:26:40 INFO - Running post-run listener: copy_logs_to_upload_dir 07:26:40 INFO - Copying logs to upload dir... 07:26:40 INFO - mkdir: /builds/slave/test/build/upload/logs 07:26:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1278.491330 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2017-01-18 07:26:40.346578) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-18 07:26:40.349757) ========= 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.SSZtr2Gfs5/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.iOpxd0UoZA/Listeners TMPDIR=/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/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/Graphics/sha512/7f67d8f3cbc3b38bd5802d4704d4bffd73147d2256a2e426559e6dad333a960ed8bcf3f24c31723115520a5cd11ae4bcafef91a8f56b9762bd874e2ff4a79fd1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/6e0b92704850c8eaa160b26a1a2e07c64190f389f5b76bfb6e47c7a0421add3bd16b727ef42c23bc4e892228bb6ebe1a22005d2c6f03a8a3fc4d1aee39d25487", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/228a75a01cb5e39ee03f23497bebd82d4990902e768644c05f764058b2a934d69aaff11f43bf0af4038d3014bb244d66940a1163b19f27cc34ef4d0543708e3b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/a079dcc330d960236c94a4b5a8a6f236297ffa532d06f198d94c067499316171814b6462cda60c58f389a516fd89baec9f5b59bbbd038566d3d43abd51d6f63b"} build_url:https://queue.taskcluster.net/v1/task/HaHq5S69Roi59vRIAd8-PA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011080 build_url: 'https://queue.taskcluster.net/v1/task/HaHq5S69Roi59vRIAd8-PA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/7f67d8f3cbc3b38bd5802d4704d4bffd73147d2256a2e426559e6dad333a960ed8bcf3f24c31723115520a5cd11ae4bcafef91a8f56b9762bd874e2ff4a79fd1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/6e0b92704850c8eaa160b26a1a2e07c64190f389f5b76bfb6e47c7a0421add3bd16b727ef42c23bc4e892228bb6ebe1a22005d2c6f03a8a3fc4d1aee39d25487", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/228a75a01cb5e39ee03f23497bebd82d4990902e768644c05f764058b2a934d69aaff11f43bf0af4038d3014bb244d66940a1163b19f27cc34ef4d0543708e3b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/a079dcc330d960236c94a4b5a8a6f236297ffa532d06f198d94c067499316171814b6462cda60c58f389a516fd89baec9f5b59bbbd038566d3d43abd51d6f63b"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-18 07:26:40.388152) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 07:26:40.388735) ========= 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.SSZtr2Gfs5/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.iOpxd0UoZA/Listeners TMPDIR=/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/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.005214 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 07:26:40.438718) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-18 07:26:40.439075) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-18 07:26:40.439475) ========= ========= Total master_lag: 0.21 =========