builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0291 starttime: 1489394611.18 results: success (0) buildid: 20170313004011 builduid: 2e80b0eeeab54e85b17b034cb1b54256 revision: d173b2b2852fde503b1e42875982ad023ab3ad8b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-13 01:43:31.176574) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-13 01:43:31.192715) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-13 01:43:31.193042) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-13 01:43:31.280604) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-13 01:43:31.280988) ========= 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.P1ipL4iSil/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.ChBpYS05HA/Listeners TMPDIR=/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-03-13 01:43:31-- 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-03-13 01:43:31 (164 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.612895 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-13 01:43:31.953457) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-13 01:43:31.953782) ========= 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.P1ipL4iSil/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.ChBpYS05HA/Listeners TMPDIR=/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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.025533 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-13 01:43:32.022466) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-13 01:43:32.022821) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d173b2b2852fde503b1e42875982ad023ab3ad8b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d173b2b2852fde503b1e42875982ad023ab3ad8b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.P1ipL4iSil/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.ChBpYS05HA/Listeners TMPDIR=/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-03-13 01:43:32,127 truncating revision to first 12 chars 2017-03-13 01:43:32,127 Setting DEBUG logging. 2017-03-13 01:43:32,127 attempt 1/10 2017-03-13 01:43:32,127 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/d173b2b2852f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-13 01:43:33,485 unpacking tar archive at: mozilla-aurora-d173b2b2852f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.656458 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-13 01:43:33.703005) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-13 01:43:33.703337) ========= script_repo_revision: d173b2b2852fde503b1e42875982ad023ab3ad8b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-13 01:43:33.703742) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-13 01:43:33.704018) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-13 01:43:33.723697) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2017-03-13 01:43:33.724178) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.P1ipL4iSil/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.ChBpYS05HA/Listeners TMPDIR=/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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 01:43:33 INFO - MultiFileLogger online at 20170313 01:43:33 in /builds/slave/test 01:43:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 01:43:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:43:33 INFO - {'append_to_log': False, 01:43:33 INFO - 'base_work_dir': '/builds/slave/test', 01:43:33 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 01:43:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:43:33 INFO - 'branch': 'Mozilla-Aurora', 01:43:33 INFO - 'buildbot_json_path': 'buildprops.json', 01:43:33 INFO - 'config_files': ('talos/mac_config.py',), 01:43:33 INFO - 'default_actions': ('clobber', 01:43:33 INFO - 'read-buildbot-config', 01:43:33 INFO - 'download-and-extract', 01:43:33 INFO - 'populate-webroot', 01:43:33 INFO - 'create-virtualenv', 01:43:33 INFO - 'install', 01:43:33 INFO - 'run-tests'), 01:43:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:43:33 INFO - 'download_minidump_stackwalk': True, 01:43:33 INFO - 'download_symbols': 'ondemand', 01:43:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:43:33 INFO - 'tooltool.py': '/tools/tooltool.py', 01:43:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:43:33 INFO - '/tools/misc-python/virtualenv.py')}, 01:43:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:43:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:43:33 INFO - 'gecko_profile': False, 01:43:33 INFO - 'gecko_profile_interval': 0, 01:43:33 INFO - 'installer_path': 'installer.exe', 01:43:33 INFO - 'log_level': 'info', 01:43:33 INFO - 'log_name': 'talos', 01:43:33 INFO - 'log_to_console': True, 01:43:33 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 01:43:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 01:43:33 INFO - 'opt_config_files': (), 01:43:33 INFO - 'pip_index': False, 01:43:33 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:43:33 INFO - 'cmd': ('bash', 01:43:33 INFO - '-c', 01:43:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:43:33 INFO - 'enabled': True, 01:43:33 INFO - 'halt_on_failure': False, 01:43:33 INFO - 'name': 'check_screen_resolution'},), 01:43:33 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:43:33 INFO - 'cmd': ('bash', 01:43:33 INFO - '-c', 01:43:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:43:33 INFO - 'enabled': True, 01:43:33 INFO - 'halt_on_failure': False, 01:43:33 INFO - 'name': 'check_screen_resolution'},), 01:43:33 INFO - 'run_cmd_checks_enabled': True, 01:43:33 INFO - 'suite': 'dromaeojs-e10s', 01:43:33 INFO - 'system_bits': '32', 01:43:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:43:33 INFO - 'title': 't-yosemite-r7-0291', 01:43:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:43:33 INFO - 'use_talos_json': True, 01:43:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:43:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:43:33 INFO - 'work_dir': 'build'} 01:43:33 INFO - [mozharness: 2017-03-13 08:43:33.921026Z] Running clobber step. 01:43:33 INFO - Running pre-action listener: _resource_record_pre_action 01:43:33 INFO - Running main action method: clobber 01:43:33 INFO - rmtree: /builds/slave/test/build 01:43:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:43:36 INFO - Running post-action listener: _resource_record_post_action 01:43:36 INFO - [mozharness: 2017-03-13 08:43:36.488234Z] Finished clobber step (success) 01:43:36 INFO - [mozharness: 2017-03-13 08:43:36.488479Z] Running read-buildbot-config step. 01:43:36 INFO - Running pre-action listener: _resource_record_pre_action 01:43:36 INFO - Running main action method: read_buildbot_config 01:43:36 INFO - Using buildbot properties: 01:43:36 INFO - { 01:43:36 INFO - "project": "", 01:43:36 INFO - "product": "firefox", 01:43:36 INFO - "script_repo_revision": "production", 01:43:36 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 01:43:36 INFO - "repository": "", 01:43:36 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 01:43:36 INFO - "buildid": "20170313004011", 01:43:36 INFO - "stage_platform": "macosx64", 01:43:36 INFO - "basedir": "/builds/slave/test", 01:43:36 INFO - "nightly_build": "True", 01:43:36 INFO - "buildnumber": 11, 01:43:36 INFO - "slavename": "t-yosemite-r7-0291", 01:43:36 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 01:43:36 INFO - "platform": "yosemite_r7", 01:43:36 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 01:43:36 INFO - "branch": "mozilla-aurora", 01:43:36 INFO - "repo_path": "releases/mozilla-aurora", 01:43:36 INFO - "revision": "d173b2b2852fde503b1e42875982ad023ab3ad8b", 01:43:36 INFO - "pgo_build": "False", 01:43:36 INFO - "builduid": "2e80b0eeeab54e85b17b034cb1b54256", 01:43:36 INFO - "slavebuilddir": "test" 01:43:36 INFO - } 01:43:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/I7YFBn11QtG5YAwMzKQTUA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg. 01:43:36 INFO - Running post-action listener: _resource_record_post_action 01:43:36 INFO - [mozharness: 2017-03-13 08:43:36.494638Z] Finished read-buildbot-config step (success) 01:43:36 INFO - [mozharness: 2017-03-13 08:43:36.494855Z] Running download-and-extract step. 01:43:36 INFO - Running pre-action listener: _resource_record_pre_action 01:43:36 INFO - Running main action method: download_and_extract 01:43:36 INFO - mkdir: /builds/slave/test/build/tests 01:43:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:43:36 INFO - trying https://queue.taskcluster.net/v1/task/I7YFBn11QtG5YAwMzKQTUA/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json 01:43:36 INFO - Downloading https://queue.taskcluster.net/v1/task/I7YFBn11QtG5YAwMzKQTUA/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 01:43:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/I7YFBn11QtG5YAwMzKQTUA/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json'}, attempt #1 01:43:37 INFO - Downloaded 1199 bytes. 01:43:37 INFO - Reading from file /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 01:43:37 INFO - Using the following test package requirements: 01:43:37 INFO - {u'common': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 01:43:37 INFO - u'cppunittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 01:43:37 INFO - u'firefox-54.0a2.en-US.mac.cppunittest.tests.zip'], 01:43:37 INFO - u'gtest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 01:43:37 INFO - u'firefox-54.0a2.en-US.mac.gtest.tests.zip'], 01:43:37 INFO - u'jittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 01:43:37 INFO - u'jsshell-mac.zip'], 01:43:37 INFO - u'mochitest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 01:43:37 INFO - u'firefox-54.0a2.en-US.mac.mochitest.tests.zip'], 01:43:37 INFO - u'mozbase': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 01:43:37 INFO - u'reftest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 01:43:37 INFO - u'firefox-54.0a2.en-US.mac.reftest.tests.zip'], 01:43:37 INFO - u'talos': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 01:43:37 INFO - u'firefox-54.0a2.en-US.mac.talos.tests.zip'], 01:43:37 INFO - u'web-platform': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 01:43:37 INFO - u'firefox-54.0a2.en-US.mac.web-platform.tests.zip'], 01:43:37 INFO - u'xpcshell': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 01:43:37 INFO - u'firefox-54.0a2.en-US.mac.xpcshell.tests.zip']} 01:43:37 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip'] for test suite category: common 01:43:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/I7YFBn11QtG5YAwMzKQTUA/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 01:43:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/I7YFBn11QtG5YAwMzKQTUA/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 01:43:37 INFO - Fetch https://queue.taskcluster.net/v1/task/I7YFBn11QtG5YAwMzKQTUA/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 01:43:39 INFO - Expected file size: 51782349 01:43:39 INFO - Obtained file size: 51782349 01:43:55 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip', u'firefox-54.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 01:43:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/I7YFBn11QtG5YAwMzKQTUA/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 01:43:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/I7YFBn11QtG5YAwMzKQTUA/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 01:43:55 INFO - Fetch https://queue.taskcluster.net/v1/task/I7YFBn11QtG5YAwMzKQTUA/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 01:43:57 INFO - Expected file size: 51782349 01:43:57 INFO - Obtained file size: 51782349 01:44:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/I7YFBn11QtG5YAwMzKQTUA/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip 01:44:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/I7YFBn11QtG5YAwMzKQTUA/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip'}, attempt #1 01:44:12 INFO - Fetch https://queue.taskcluster.net/v1/task/I7YFBn11QtG5YAwMzKQTUA/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip into memory 01:44:13 INFO - Expected file size: 14404424 01:44:13 INFO - Obtained file size: 14404424 01:44:13 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')]} 01:44:13 INFO - trying https://queue.taskcluster.net/v1/task/I7YFBn11QtG5YAwMzKQTUA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 01:44:13 INFO - Downloading https://queue.taskcluster.net/v1/task/I7YFBn11QtG5YAwMzKQTUA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg 01:44:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/I7YFBn11QtG5YAwMzKQTUA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg'}, attempt #1 01:44:16 INFO - Downloaded 74642896 bytes. 01:44:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/I7YFBn11QtG5YAwMzKQTUA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 01:44:16 INFO - mkdir: /builds/slave/test/properties 01:44:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:44:16 INFO - Writing to file /builds/slave/test/properties/build_url 01:44:16 INFO - Contents: 01:44:16 INFO - build_url:https://queue.taskcluster.net/v1/task/I7YFBn11QtG5YAwMzKQTUA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 01:44:16 INFO - Running post-action listener: _resource_record_post_action 01:44:16 INFO - Running post-action listener: set_extra_try_arguments 01:44:16 INFO - [mozharness: 2017-03-13 08:44:16.750246Z] Finished download-and-extract step (success) 01:44:16 INFO - [mozharness: 2017-03-13 08:44:16.750369Z] Running populate-webroot step. 01:44:16 INFO - Running pre-action listener: _resource_record_pre_action 01:44:16 INFO - Running main action method: populate_webroot 01:44:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:44:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:44:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:44:16 INFO - '--tppagecycles', 01:44:16 INFO - '7'], 01:44:16 INFO - 'tests': ['tsvgm']}}, 01:44:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:44:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:44:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:44:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:44:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:44:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:44:16 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 01:44:16 INFO - 'talos_options': ['--disable-e10s'], 01:44:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:44:16 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 01:44:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:44:16 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 01:44:16 INFO - 'talos_options': ['--disable-e10s'], 01:44:16 INFO - 'tests': ['damp', 'tps']}, 01:44:16 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 01:44:16 INFO - 'tests': ['damp', 'tps']}, 01:44:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:44:16 INFO - 'tests': ['dromaeo_dom']}, 01:44:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:44:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:44:16 INFO - 'tests': ['basic_compositor_video']}, 01:44:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:44:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:44:16 INFO - 'tests': ['a11yr', 01:44:16 INFO - 'ts_paint', 01:44:16 INFO - 'tpaint', 01:44:16 INFO - 'sessionrestore', 01:44:16 INFO - 'sessionrestore_no_auto_restore', 01:44:16 INFO - 'tabpaint']}, 01:44:16 INFO - 'other-e10s': {'tests': ['a11yr', 01:44:16 INFO - 'ts_paint', 01:44:16 INFO - 'tpaint', 01:44:16 INFO - 'sessionrestore', 01:44:16 INFO - 'sessionrestore_no_auto_restore', 01:44:16 INFO - 'tabpaint']}, 01:44:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:44:16 INFO - 'ts_paint', 01:44:16 INFO - 'tpaint', 01:44:16 INFO - 'sessionrestore', 01:44:16 INFO - 'sessionrestore_no_auto_restore', 01:44:16 INFO - 'tabpaint']}, 01:44:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:44:16 INFO - 'ts_paint', 01:44:16 INFO - 'tpaint', 01:44:16 INFO - 'sessionrestore', 01:44:16 INFO - 'sessionrestore_no_auto_restore', 01:44:16 INFO - 'tabpaint']}, 01:44:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:44:16 INFO - 'tests': ['a11yr', 01:44:16 INFO - 'ts_paint', 01:44:16 INFO - 'tpaint', 01:44:16 INFO - 'sessionrestore', 01:44:16 INFO - 'sessionrestore_no_auto_restore', 01:44:16 INFO - 'tabpaint']}, 01:44:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:44:16 INFO - 'tests': ['a11yr', 01:44:16 INFO - 'ts_paint', 01:44:16 INFO - 'tpaint', 01:44:16 INFO - 'sessionrestore', 01:44:16 INFO - 'sessionrestore_no_auto_restore', 01:44:16 INFO - 'tabpaint']}, 01:44:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:44:16 INFO - 'tests': ['tsvgx', 01:44:16 INFO - 'tsvgr_opacity', 01:44:16 INFO - 'tart', 01:44:16 INFO - 'tscrollx', 01:44:16 INFO - 'cart', 01:44:16 INFO - 'tsvg_static']}, 01:44:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:44:16 INFO - 'tsvgr_opacity', 01:44:16 INFO - 'tart', 01:44:16 INFO - 'tscrollx', 01:44:16 INFO - 'cart', 01:44:16 INFO - 'tsvg_static']}, 01:44:16 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 01:44:16 INFO - 'talos_options': ['--disable-e10s'], 01:44:16 INFO - 'tests': ['tp5o']}, 01:44:16 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 01:44:16 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 01:44:16 INFO - 'talos_options': ['--disable-e10s', 01:44:16 INFO - '--xperf_path', 01:44:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:44:16 INFO - 'tests': ['tp5n']}, 01:44:16 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 01:44:16 INFO - 'talos_options': ['--xperf_path', 01:44:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:44:16 INFO - 'tests': ['tp5n']}}, 01:44:16 INFO - 'talos.zip': {'path': '', 01:44:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:44:16 INFO - Running post-action listener: _resource_record_post_action 01:44:16 INFO - [mozharness: 2017-03-13 08:44:16.768452Z] Finished populate-webroot step (success) 01:44:16 INFO - [mozharness: 2017-03-13 08:44:16.768539Z] Running create-virtualenv step. 01:44:16 INFO - Running pre-action listener: _resource_record_pre_action 01:44:16 INFO - Running main action method: create_virtualenv 01:44:16 INFO - Creating virtualenv /builds/slave/test/build/venv 01:44:16 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 01:44:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:44:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:44:16 INFO - Using real prefix '/tools/python27' 01:44:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:44:17 INFO - Installing distribute.............................................................................................................................................................................................done. 01:44:20 INFO - Installing pip.................done. 01:44:20 INFO - Return code: 0 01:44:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 01:44:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 01:44:20 INFO - Reading from file tmpfile_stdout 01:44:20 INFO - Output received: 01:44:20 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) 01:44:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:44:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:44:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:44:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:44:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:44:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:44:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:44:20 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 0x10eaa6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eaa9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb49cc21a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e884d30>, '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 0x10e7abdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e879be8>, '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.P1ipL4iSil/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.ChBpYS05HA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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 01:44:20 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 01:44:20 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 01:44:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P1ipL4iSil/Render', 01:44:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:44:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:44:20 INFO - 'HOME': '/Users/cltbld', 01:44:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:44:20 INFO - 'LOGNAME': 'cltbld', 01:44:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:44:20 INFO - 'MOZ_NO_REMOTE': '1', 01:44:20 INFO - 'NO_EM_RESTART': '1', 01:44:20 INFO - 'PAGER': '/bin/cat', 01:44:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:44:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:44:20 INFO - 'PWD': '/builds/slave/test', 01:44:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:44:20 INFO - 'SHELL': '/bin/bash', 01:44:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ChBpYS05HA/Listeners', 01:44:20 INFO - 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', 01:44:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:44:20 INFO - 'USER': 'cltbld', 01:44:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:44:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:44:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:44:20 INFO - 'XPC_FLAGS': '0x0', 01:44:20 INFO - 'XPC_SERVICE_NAME': '0', 01:44:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:44:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:44:21 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 01:44:21 INFO - Cleaning up... 01:44:21 INFO - Return code: 0 01:44:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:44: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')]} 01:44:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:44:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:44: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')]} 01:44:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:44:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:44:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10eaa6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eaa9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb49cc21a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e884d30>, '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 0x10e7abdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e879be8>, '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.P1ipL4iSil/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.ChBpYS05HA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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 01:44:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 01:44:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 01:44:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P1ipL4iSil/Render', 01:44:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:44:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:44:21 INFO - 'HOME': '/Users/cltbld', 01:44:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:44:21 INFO - 'LOGNAME': 'cltbld', 01:44:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:44:21 INFO - 'MOZ_NO_REMOTE': '1', 01:44:21 INFO - 'NO_EM_RESTART': '1', 01:44:21 INFO - 'PAGER': '/bin/cat', 01:44:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:44:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:44:21 INFO - 'PWD': '/builds/slave/test', 01:44:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:44:21 INFO - 'SHELL': '/bin/bash', 01:44:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ChBpYS05HA/Listeners', 01:44:21 INFO - 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', 01:44:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:44:21 INFO - 'USER': 'cltbld', 01:44:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:44:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:44:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:44:21 INFO - 'XPC_FLAGS': '0x0', 01:44:21 INFO - 'XPC_SERVICE_NAME': '0', 01:44:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:44:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:44:21 INFO - Downloading/unpacking psutil>=3.1.1 01:44:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:44:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:44:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:44:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:44:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:44:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:44:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:44:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:44:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:44:25 INFO - Installing collected packages: psutil 01:44:25 INFO - Running setup.py install for psutil 01:44:25 INFO - building 'psutil._psutil_osx' extension 01:44:25 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 01:44:25 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 01:44:25 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 01:44:25 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 01:44:25 INFO - building 'psutil._psutil_posix' extension 01:44:25 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 01:44:25 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 01:44:25 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 01:44:25 INFO - ^ 01:44:25 INFO - 1 warning generated. 01:44:26 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 01:44:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:44:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:44:26 INFO - Successfully installed psutil 01:44:26 INFO - Cleaning up... 01:44:26 INFO - Return code: 0 01:44:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:44: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')]} 01:44:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:44:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:44: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')]} 01:44:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:44:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:44:26 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 0x10eaa6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eaa9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb49cc21a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e884d30>, '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 0x10e7abdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e879be8>, '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.P1ipL4iSil/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.ChBpYS05HA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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 01:44:26 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 01:44:26 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 01:44:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P1ipL4iSil/Render', 01:44:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:44:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:44:26 INFO - 'HOME': '/Users/cltbld', 01:44:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:44:26 INFO - 'LOGNAME': 'cltbld', 01:44:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:44:26 INFO - 'MOZ_NO_REMOTE': '1', 01:44:26 INFO - 'NO_EM_RESTART': '1', 01:44:26 INFO - 'PAGER': '/bin/cat', 01:44:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:44:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:44:26 INFO - 'PWD': '/builds/slave/test', 01:44:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:44:26 INFO - 'SHELL': '/bin/bash', 01:44:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ChBpYS05HA/Listeners', 01:44:26 INFO - 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', 01:44:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:44:26 INFO - 'USER': 'cltbld', 01:44:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:44:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:44:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:44:26 INFO - 'XPC_FLAGS': '0x0', 01:44:26 INFO - 'XPC_SERVICE_NAME': '0', 01:44:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:44:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:44:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:44:26 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 01:44:26 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 01:44:26 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 01:44:26 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 01:44:26 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 01:44:26 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 01:44:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:44:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:44:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:44:29 INFO - Installing collected packages: mozsystemmonitor 01:44:29 INFO - Running setup.py install for mozsystemmonitor 01:44:29 INFO - Successfully installed mozsystemmonitor 01:44:29 INFO - Cleaning up... 01:44:29 INFO - Return code: 0 01:44:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:44:29 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')]} 01:44:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:44:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:44:29 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')]} 01:44:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:44:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:44:29 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 0x10eaa6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eaa9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb49cc21a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e884d30>, '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 0x10e7abdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e879be8>, '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.P1ipL4iSil/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.ChBpYS05HA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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 01:44:29 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 01:44:29 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 01:44:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P1ipL4iSil/Render', 01:44:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:44:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:44:29 INFO - 'HOME': '/Users/cltbld', 01:44:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:44:29 INFO - 'LOGNAME': 'cltbld', 01:44:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:44:29 INFO - 'MOZ_NO_REMOTE': '1', 01:44:29 INFO - 'NO_EM_RESTART': '1', 01:44:29 INFO - 'PAGER': '/bin/cat', 01:44:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:44:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:44:29 INFO - 'PWD': '/builds/slave/test', 01:44:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:44:29 INFO - 'SHELL': '/bin/bash', 01:44:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ChBpYS05HA/Listeners', 01:44:29 INFO - 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', 01:44:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:44:29 INFO - 'USER': 'cltbld', 01:44:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:44:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:44:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:44:29 INFO - 'XPC_FLAGS': '0x0', 01:44:29 INFO - 'XPC_SERVICE_NAME': '0', 01:44:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:44:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:44:29 INFO - Downloading/unpacking jsonschema==2.5.1 01:44:29 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 01:44:29 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 01:44:29 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 01:44:29 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 01:44:29 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 01:44:29 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 01:44:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:44:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:44:32 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 01:44:32 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 01:44:32 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 01:44:32 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 01:44:32 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 01:44:32 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 01:44:32 INFO - Downloading functools32-3.2.3-2.tar.gz 01:44:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:44:32 INFO - warning: no files found matching '*.txt' 01:44:32 INFO - no previously-included directories found matching 'build' 01:44:32 INFO - no previously-included directories found matching 'dist' 01:44:32 INFO - no previously-included directories found matching '.git*' 01:44:32 INFO - Installing collected packages: jsonschema, functools32 01:44:32 INFO - Running setup.py install for functools32 01:44:33 INFO - warning: no files found matching '*.txt' 01:44:33 INFO - no previously-included directories found matching 'build' 01:44:33 INFO - no previously-included directories found matching 'dist' 01:44:33 INFO - no previously-included directories found matching '.git*' 01:44:33 INFO - Successfully installed jsonschema functools32 01:44:33 INFO - Cleaning up... 01:44:33 INFO - Return code: 0 01:44:33 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 01:44:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:44:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:44:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:44:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:44:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:44:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:44:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10eaa6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eaa9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb49cc21a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e884d30>, '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 0x10e7abdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e879be8>, '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.P1ipL4iSil/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.ChBpYS05HA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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 01:44:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 01:44:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 01:44:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P1ipL4iSil/Render', 01:44:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:44:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:44:33 INFO - 'HOME': '/Users/cltbld', 01:44:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:44:33 INFO - 'LOGNAME': 'cltbld', 01:44:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:44:33 INFO - 'MOZ_NO_REMOTE': '1', 01:44:33 INFO - 'NO_EM_RESTART': '1', 01:44:33 INFO - 'PAGER': '/bin/cat', 01:44:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:44:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:44:33 INFO - 'PWD': '/builds/slave/test', 01:44:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:44:33 INFO - 'SHELL': '/bin/bash', 01:44:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ChBpYS05HA/Listeners', 01:44:33 INFO - 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', 01:44:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:44:33 INFO - 'USER': 'cltbld', 01:44:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:44:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:44:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:44:33 INFO - 'XPC_FLAGS': '0x0', 01:44:33 INFO - 'XPC_SERVICE_NAME': '0', 01:44:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:44:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:44:33 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 01:44:33 INFO - Cleaning up... 01:44:33 INFO - Return code: 0 01:44:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:44:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:44:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:44:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:44:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:44:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:44:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:44:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10eaa6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eaa9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb49cc21a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e884d30>, '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 0x10e7abdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e879be8>, '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.P1ipL4iSil/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.ChBpYS05HA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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 01:44:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:44:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 01:44:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P1ipL4iSil/Render', 01:44:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:44:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:44:33 INFO - 'HOME': '/Users/cltbld', 01:44:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:44:33 INFO - 'LOGNAME': 'cltbld', 01:44:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:44:33 INFO - 'MOZ_NO_REMOTE': '1', 01:44:33 INFO - 'NO_EM_RESTART': '1', 01:44:33 INFO - 'PAGER': '/bin/cat', 01:44:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:44:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:44:33 INFO - 'PWD': '/builds/slave/test', 01:44:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:44:33 INFO - 'SHELL': '/bin/bash', 01:44:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ChBpYS05HA/Listeners', 01:44:33 INFO - 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', 01:44:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:44:33 INFO - 'USER': 'cltbld', 01:44:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:44:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:44:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:44:33 INFO - 'XPC_FLAGS': '0x0', 01:44:33 INFO - 'XPC_SERVICE_NAME': '0', 01:44:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:44:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:44:33 INFO - Downloading/unpacking blobuploader==1.2.4 01:44:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:44:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:44:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:44:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:44:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:44:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:44:36 INFO - Downloading blobuploader-1.2.4.tar.gz 01:44:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:44:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:44:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:44:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:44:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:44:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:44:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:44:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:44:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:44:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:44:37 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 01:44:37 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 01:44:37 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 01:44:37 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 01:44:37 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 01:44:37 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 01:44:37 INFO - Downloading docopt-0.6.1.tar.gz 01:44:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:44:37 INFO - Installing collected packages: blobuploader, requests, docopt 01:44:37 INFO - Running setup.py install for blobuploader 01:44:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:44:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:44:37 INFO - Running setup.py install for requests 01:44:38 INFO - Running setup.py install for docopt 01:44:38 INFO - Successfully installed blobuploader requests docopt 01:44:38 INFO - Cleaning up... 01:44:38 INFO - Return code: 0 01:44:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:44:38 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')]} 01:44:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:44:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:44:38 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')]} 01:44:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:44:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:44:38 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 0x10eaa6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eaa9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb49cc21a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e884d30>, '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 0x10e7abdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e879be8>, '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.P1ipL4iSil/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.ChBpYS05HA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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 01:44:38 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 01:44:38 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 01:44:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P1ipL4iSil/Render', 01:44:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:44:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:44:38 INFO - 'HOME': '/Users/cltbld', 01:44:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:44:38 INFO - 'LOGNAME': 'cltbld', 01:44:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:44:38 INFO - 'MOZ_NO_REMOTE': '1', 01:44:38 INFO - 'NO_EM_RESTART': '1', 01:44:38 INFO - 'PAGER': '/bin/cat', 01:44:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:44:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:44:38 INFO - 'PWD': '/builds/slave/test', 01:44:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:44:38 INFO - 'SHELL': '/bin/bash', 01:44:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ChBpYS05HA/Listeners', 01:44:38 INFO - 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', 01:44:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:44:38 INFO - 'USER': 'cltbld', 01:44:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:44:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:44:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:44:38 INFO - 'XPC_FLAGS': '0x0', 01:44:38 INFO - 'XPC_SERVICE_NAME': '0', 01:44:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:44:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:44:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:44:38 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-UFypE1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:44:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:44:38 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-UkV9lN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:44:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:44:38 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-3dBqBU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:44:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:44:38 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-nYbNHB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:44:39 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-ZJsANW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:44:39 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-gdao7z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:44:39 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-7meegD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:44:39 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-lbvD9J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:44:39 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-crYoxr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:44:39 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-Ikwbhy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:44:39 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-TM4X3H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:44:39 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-I69Y0U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:44:39 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-kTVT5q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:44:40 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-r0n6cs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:44:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:44:40 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-oDE4us-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:44:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:44:40 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-bTeMxK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:44:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:44:40 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-GQkFac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:44:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:44:40 INFO - Running setup.py install for manifestparser 01:44:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:44:40 INFO - Running setup.py install for mozcrash 01:44:40 INFO - Running setup.py install for mozdebug 01:44:40 INFO - Running setup.py install for mozdevice 01:44:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:44:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:44:41 INFO - Running setup.py install for mozfile 01:44:41 INFO - Running setup.py install for mozhttpd 01:44:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:44:41 INFO - Running setup.py install for mozinfo 01:44:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:44:41 INFO - Running setup.py install for mozInstall 01:44:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:44:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:44:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:44:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:44:41 INFO - Running setup.py install for mozleak 01:44:41 INFO - Running setup.py install for mozlog 01:44:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:44:41 INFO - Running setup.py install for moznetwork 01:44:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:44:42 INFO - Running setup.py install for mozprocess 01:44:42 INFO - Running setup.py install for mozprofile 01:44:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:44:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:44:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:44:42 INFO - Running setup.py install for mozrunner 01:44:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:44:42 INFO - Running setup.py install for mozscreenshot 01:44:42 INFO - Running setup.py install for moztest 01:44:42 INFO - Running setup.py install for mozversion 01:44:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:44:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:44:42 INFO - Cleaning up... 01:44:42 INFO - Return code: 0 01:44:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:44:42 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')]} 01:44:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:44:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:44:42 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')]} 01:44:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:44:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:44:42 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 0x10eaa6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eaa9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb49cc21a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e884d30>, '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 0x10e7abdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e879be8>, '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.P1ipL4iSil/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.ChBpYS05HA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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 01:44:42 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 01:44:42 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 01:44:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P1ipL4iSil/Render', 01:44:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:44:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:44:42 INFO - 'HOME': '/Users/cltbld', 01:44:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:44:42 INFO - 'LOGNAME': 'cltbld', 01:44:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:44:42 INFO - 'MOZ_NO_REMOTE': '1', 01:44:42 INFO - 'NO_EM_RESTART': '1', 01:44:42 INFO - 'PAGER': '/bin/cat', 01:44:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:44:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:44:42 INFO - 'PWD': '/builds/slave/test', 01:44:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:44:42 INFO - 'SHELL': '/bin/bash', 01:44:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ChBpYS05HA/Listeners', 01:44:42 INFO - 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', 01:44:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:44:42 INFO - 'USER': 'cltbld', 01:44:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:44:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:44:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:44:42 INFO - 'XPC_FLAGS': '0x0', 01:44:42 INFO - 'XPC_SERVICE_NAME': '0', 01:44:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:44:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:44:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:44:43 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-iMQEIE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:44:43 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)) 01:44:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:44:43 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-XiV_ZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:44:43 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)) 01:44:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:44:43 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-567YVg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:44:43 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)) 01:44:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:44:43 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-StBFia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:44:43 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)) 01:44:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:44:43 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-RAMkU3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:44:43 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)) 01:44:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:44:43 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-dU1PWU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:44:43 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)) 01:44:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:44:43 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-pOG_S9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:44:43 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)) 01:44:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:44:43 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-hcKmJJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:44:44 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)) 01:44:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:44:44 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-2CW37K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:44:44 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)) 01:44:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:44:44 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-XmXITq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:44:44 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)) 01:44:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:44:44 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-JIkLsk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:44:44 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)) 01:44:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:44:44 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-WrqE4y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:44:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 01:44:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:44:44 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-y4Gfqb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:44:44 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)) 01:44:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:44:44 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-mdbmSa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:44:44 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)) 01:44:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:44:44 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-n8XETr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:44:44 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)) 01:44:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:44:44 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-h6WQh3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:44:44 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)) 01:44:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:44:44 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-h5AZOV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:44:45 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)) 01:44:45 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)) 01:44:45 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)) 01:44:45 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)) 01:44:45 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)) 01:44:45 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)) 01:44:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:44:45 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 01:44:45 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 01:44:45 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 01:44:45 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 01:44:45 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 01:44:45 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 01:44:47 INFO - Downloading blessings-1.6.tar.gz 01:44:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:44:47 INFO - Installing collected packages: blessings 01:44:47 INFO - Running setup.py install for blessings 01:44:47 INFO - Successfully installed blessings 01:44:47 INFO - Cleaning up... 01:44:48 INFO - Return code: 0 01:44:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:44:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:44:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:44:48 INFO - Reading from file tmpfile_stdout 01:44:48 INFO - Current package versions: 01:44:48 INFO - blessings == 1.6 01:44:48 INFO - blobuploader == 1.2.4 01:44:48 INFO - docopt == 0.6.1 01:44:48 INFO - functools32 == 3.2.3-2 01:44:48 INFO - jsonschema == 2.5.1 01:44:48 INFO - manifestparser == 1.1 01:44:48 INFO - mozInstall == 1.12 01:44:48 INFO - mozcrash == 1.0 01:44:48 INFO - mozdebug == 0.1 01:44:48 INFO - mozdevice == 0.49 01:44:48 INFO - mozfile == 1.2 01:44:48 INFO - mozhttpd == 0.7 01:44:48 INFO - mozinfo == 0.9 01:44:48 INFO - mozleak == 0.1 01:44:48 INFO - mozlog == 3.4 01:44:48 INFO - moznetwork == 0.27 01:44:48 INFO - mozprocess == 0.25 01:44:48 INFO - mozprofile == 0.28 01:44:48 INFO - mozrunner == 6.13 01:44:48 INFO - mozscreenshot == 0.1 01:44:48 INFO - mozsystemmonitor == 0.3 01:44:48 INFO - moztest == 0.8 01:44:48 INFO - mozversion == 1.4 01:44:48 INFO - psutil == 3.1.1 01:44:48 INFO - requests == 1.2.3 01:44:48 INFO - wsgiref == 0.1.2 01:44:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:44:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:44:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:44:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:44:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:44:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:44:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:44:48 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 0x10eaa6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eaa9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb49cc21a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e884d30>, '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 0x10e7abdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e879be8>, '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.P1ipL4iSil/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.ChBpYS05HA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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 01:44:48 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 01:44:48 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 01:44:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P1ipL4iSil/Render', 01:44:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:44:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:44:48 INFO - 'HOME': '/Users/cltbld', 01:44:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:44:48 INFO - 'LOGNAME': 'cltbld', 01:44:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:44:48 INFO - 'MOZ_NO_REMOTE': '1', 01:44:48 INFO - 'NO_EM_RESTART': '1', 01:44:48 INFO - 'PAGER': '/bin/cat', 01:44:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:44:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:44:48 INFO - 'PWD': '/builds/slave/test', 01:44:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:44:48 INFO - 'SHELL': '/bin/bash', 01:44:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ChBpYS05HA/Listeners', 01:44:48 INFO - 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', 01:44:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:44:48 INFO - 'USER': 'cltbld', 01:44:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:44:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:44:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:44:48 INFO - 'XPC_FLAGS': '0x0', 01:44:48 INFO - 'XPC_SERVICE_NAME': '0', 01:44:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:44:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:44:48 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)) 01:44:48 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)) 01:44:48 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)) 01:44:48 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)) 01:44:48 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)) 01:44:48 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)) 01:44:48 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)) 01:44:48 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)) 01:44:48 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)) 01:44:48 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)) 01:44:48 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)) 01:44:48 INFO - Cleaning up... 01:44:48 INFO - Return code: 0 01:44:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:44:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:44:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:44:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:44:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:44:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:44:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:44:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10eaa6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eaa9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb49cc21a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e884d30>, '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 0x10e7abdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e879be8>, '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.P1ipL4iSil/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.ChBpYS05HA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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 01:44:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 01:44:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 01:44:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P1ipL4iSil/Render', 01:44:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:44:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:44:48 INFO - 'HOME': '/Users/cltbld', 01:44:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:44:48 INFO - 'LOGNAME': 'cltbld', 01:44:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:44:48 INFO - 'MOZ_NO_REMOTE': '1', 01:44:48 INFO - 'NO_EM_RESTART': '1', 01:44:48 INFO - 'PAGER': '/bin/cat', 01:44:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:44:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:44:48 INFO - 'PWD': '/builds/slave/test', 01:44:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:44:48 INFO - 'SHELL': '/bin/bash', 01:44:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ChBpYS05HA/Listeners', 01:44:48 INFO - 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', 01:44:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:44:48 INFO - 'USER': 'cltbld', 01:44:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:44:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:44:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:44:48 INFO - 'XPC_FLAGS': '0x0', 01:44:48 INFO - 'XPC_SERVICE_NAME': '0', 01:44:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:44:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:44:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:44:48 INFO - Cleaning up... 01:44:48 INFO - Return code: 0 01:44:48 INFO - Running post-action listener: _resource_record_post_action 01:44:48 INFO - Running post-action listener: _start_resource_monitoring 01:44:48 INFO - Starting resource monitoring. 01:44:48 INFO - [mozharness: 2017-03-13 08:44:48.887434Z] Finished create-virtualenv step (success) 01:44:48 INFO - [mozharness: 2017-03-13 08:44:48.888361Z] Running install step. 01:44:48 INFO - Running pre-action listener: _resource_record_pre_action 01:44:48 INFO - Running main action method: install 01:44:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:44:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:44:49 INFO - Reading from file tmpfile_stdout 01:44:49 INFO - Detecting whether we're running mozinstall >=1.0... 01:44:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:44:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:44:49 INFO - Reading from file tmpfile_stdout 01:44:49 INFO - Output received: 01:44:49 INFO - Usage: mozinstall [options] installer 01:44:49 INFO - Options: 01:44:49 INFO - -h, --help show this help message and exit 01:44:49 INFO - -d DEST, --destination=DEST 01:44:49 INFO - Directory to install application into. [default: 01:44:49 INFO - "/builds/slave/test"] 01:44:49 INFO - --app=APP Application being installed. [default: firefox] 01:44:49 INFO - mkdir: /builds/slave/test/build/application 01:44:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 01:44:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 01:45:09 INFO - Reading from file tmpfile_stdout 01:45:09 INFO - Output received: 01:45:09 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 01:45:09 INFO - Running post-action listener: _resource_record_post_action 01:45:09 INFO - [mozharness: 2017-03-13 08:45:09.251071Z] Finished install step (success) 01:45:09 INFO - [mozharness: 2017-03-13 08:45:09.251166Z] Running run-tests step. 01:45:09 INFO - Running pre-action listener: _resource_record_pre_action 01:45:09 INFO - Running main action method: run_tests 01:45:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:45:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:45:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:45:09 INFO - 2017-03-13 01:45:09.263 screenresolution[1637:8867] starting screenresolution argv=screenresolution get 01:45:09 INFO - 2017-03-13 01:45:09.266 screenresolution[1637:8867] Display 0: 1600x1200x32@60 01:45:09 INFO - 2017-03-13 01:45:09.271 screenresolution[1638:8870] starting screenresolution argv=screenresolution list 01:45:09 INFO - Available Modes on Display 0 01:45:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:45:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:45:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:45:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:45:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:45:09 INFO - Intel Iris: 01:45:09 INFO - Chipset Model: Intel Iris 01:45:09 INFO - Type: GPU 01:45:09 INFO - Bus: Built-In 01:45:09 INFO - VRAM (Dynamic, Max): 1536 MB 01:45:09 INFO - Vendor: Intel (0x8086) 01:45:09 INFO - Device ID: 0x0a2e 01:45:09 INFO - Revision ID: 0x0009 01:45:09 INFO - Displays: 01:45:09 INFO - Display: 01:45:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:45:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:45:09 INFO - Display Serial Number: 1600x1200 60 01:45:09 INFO - Main Display: Yes 01:45:09 INFO - Mirror: Off 01:45:09 INFO - Online: Yes 01:45:09 INFO - Rotation: Supported 01:45:09 INFO - Return code: 0 01:45:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:45:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:45:09 INFO - Python 2.7.3 01:45:09 INFO - Return code: 0 01:45:09 INFO - grabbing minidump binary from tooltool 01:45:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:45:09 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 0x10e884d30>, '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 0x10e7abdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e879be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:45:09 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 01:45:09 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 01:45:09 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 01:45:09 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:45:09 INFO - Return code: 0 01:45:09 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 01:45:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:45:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:45:09 INFO - ENV: RUST_BACKTRACE is now 1 01:45:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 01:45:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:45:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I7YFBn11QtG5YAwMzKQTUA/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0291', '--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 01:45:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/I7YFBn11QtG5YAwMzKQTUA/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0291 --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 01:45:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P1ipL4iSil/Render', 01:45:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:45:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:45:09 INFO - 'HOME': '/Users/cltbld', 01:45:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:45:09 INFO - 'LOGNAME': 'cltbld', 01:45:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:45:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 01:45:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:45:09 INFO - 'MOZ_NO_REMOTE': '1', 01:45:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:45:09 INFO - 'NO_EM_RESTART': '1', 01:45:09 INFO - 'PAGER': '/bin/cat', 01:45:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:45:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:45:09 INFO - 'PWD': '/builds/slave/test', 01:45:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:45:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:45:09 INFO - 'RUST_BACKTRACE': '1', 01:45:09 INFO - 'SHELL': '/bin/bash', 01:45:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ChBpYS05HA/Listeners', 01:45:09 INFO - 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', 01:45:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:45:09 INFO - 'USER': 'cltbld', 01:45:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:45:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:45:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:45:09 INFO - 'XPC_FLAGS': '0x0', 01:45:09 INFO - 'XPC_SERVICE_NAME': '0', 01:45:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:45:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I7YFBn11QtG5YAwMzKQTUA/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0291', '--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 01:45:09 INFO - mozversion application_buildid: 20170313004011 01:45:09 INFO - mozversion application_changeset: d173b2b2852fde503b1e42875982ad023ab3ad8b 01:45:09 INFO - mozversion application_display_name: FirefoxDeveloperEdition 01:45:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:45:09 INFO - mozversion application_name: Firefox 01:45:09 INFO - mozversion application_remotingname: firefox-dev 01:45:09 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:45:09 INFO - mozversion application_vendor: Mozilla 01:45:09 INFO - mozversion application_version: 54.0a2 01:45:09 INFO - mozversion platform_buildid: 20170313004011 01:45:09 INFO - mozversion platform_changeset: d173b2b2852fde503b1e42875982ad023ab3ad8b 01:45:09 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:45:09 INFO - mozversion platform_version: 54.0a2 01:45:09 INFO - using testdate: 1489394709 01:45:09 INFO - actual date: 1489394709 01:45:09 INFO - starting webserver on 'localhost:49243' 01:45:09 INFO - SUITE-START | Running 2 tests 01:45:09 INFO - TEST-START | dromaeo_css 01:45:09 INFO - operating with platform_type : mac_ 01:45:09 INFO - Initialising browser for dromaeo_css test... 01:45:09 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/tmpxGqQSZ/profile http://localhost:49243/getInfo.html) 01:45:12 INFO - PROCESS | 1648 | 2017-03-13 01:45:12.919 plugin-container[1652:9023] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x934b, name = 'com.apple.tsm.portname' 01:45:12 INFO - PROCESS | 1648 | See /usr/include/servers/bootstrap_defs.h for the error codes. 01:45:12 INFO - PROCESS | 1648 | 2017-03-13 01:45:12.919 plugin-container[1652:9023] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x970f, name = 'com.apple.CFPasteboardClient' 01:45:12 INFO - PROCESS | 1648 | See /usr/include/servers/bootstrap_defs.h for the error codes. 01:45:12 INFO - PROCESS | 1648 | 2017-03-13 01:45:12.919 plugin-container[1652:9023] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 01:45:12 INFO - PROCESS | 1648 | __metrics Screen width/height:1600/1200 01:45:12 INFO - PROCESS | 1648 | colorDepth:24 01:45:12 INFO - PROCESS | 1648 | Browser inner width/height: 1024/689 01:45:12 INFO - PROCESS | 1648 | __metrics 01:45:13 ERROR - PROCESS | 1648 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3353: TypeError: this.tabs is undefined 01:45:13 INFO - TEST-INFO | 1648: exit 0 01:45:13 INFO - Browser initialized. 01:45:13 INFO - Running cycle 1/1 for dromaeo_css test... 01:45:13 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/tmpxGqQSZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:45:16 INFO - PROCESS | 1653 | 2017-03-13 01:45:16.338 plugin-container[1654:9159] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b3f, name = 'com.apple.tsm.portname' 01:45:16 INFO - PROCESS | 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 01:45:16 INFO - PROCESS | 1653 | 2017-03-13 01:45:16.339 plugin-container[1654:9159] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x440b, name = 'com.apple.CFPasteboardClient' 01:45:16 INFO - PROCESS | 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 01:45:16 INFO - PROCESS | 1653 | 2017-03-13 01:45:16.339 plugin-container[1654:9159] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 01:45:26 INFO - PROCESS | 1653 | RSS: Main: 220229632 01:45:26 INFO - PROCESS | 1653 | 01:48:30 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49243/tests/dromaeo/cssquery-ext.html) 01:48:32 INFO - PROCESS | 1653 | RSS: Main: 242122752 01:48:32 INFO - PROCESS | 1653 | 01:50:14 INFO - PROCESS | 1653 | ************************* 01:50:14 INFO - PROCESS | 1653 | A coding exception was thrown and uncaught in a Task. 01:50:14 INFO - PROCESS | 1653 | 01:50:14 ERROR - PROCESS | 1653 | Full message: TypeError: NetworkError when attempting to fetch resource. 01:50:14 INFO - PROCESS | 1653 | Full stack: 01:50:14 INFO - PROCESS | 1653 | ************************* 01:51:34 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-ext.html (next: http://localhost:49243/tests/dromaeo/cssquery-jquery.html) 01:51:35 INFO - PROCESS | 1653 | RSS: Main: 251101184 01:51:35 INFO - PROCESS | 1653 | 01:54:37 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49243/tests/dromaeo/cssquery-mootools.html) 01:54:37 INFO - PROCESS | 1653 | RSS: Main: 261009408 01:54:37 INFO - PROCESS | 1653 | 01:57:39 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49243/tests/dromaeo/cssquery-prototype.html) 01:57:40 INFO - PROCESS | 1653 | RSS: Main: 257253376 01:57:40 INFO - PROCESS | 1653 | 02:00:43 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49243/tests/dromaeo/cssquery-yui.html) 02:00:44 INFO - PROCESS | 1653 | RSS: Main: 262246400 02:00:44 INFO - PROCESS | 1653 | 02:03:47 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-yui.html (next: http://localhost:49243/tests/dromaeo/cssquery-dojo.html) 02:03:47 INFO - PROCESS | 1653 | RSS: Main: 258478080 02:03:47 INFO - PROCESS | 1653 | 02:03:47 INFO - PROCESS | 1653 | __start_tp_report 02:03:47 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 02:03:47 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 02:03:47 INFO - PROCESS | 1653 | |i|pagename|runs| 02:03:47 INFO - PROCESS | 1653 | |0;dojo.html;3480.5301284326615;3500.719942404608;3507.0180349502148;3511.929761404772;3518.2611651553166;6077.4530292273685;6079.969600151993;6084.878302433955;6105.511559075275;6116;5961.284645842494;6030.66831324277;6054.636721796695;6108.877822443548;6137.785177518787;5424.321959755031;5487.6981766002855;5490.972545137269;5493.972530137344;5580.218769372271;3907.355286377744;5545.611807173499;5572.442755724415;5576.637518561301;5618.297712785902;5350.197470379435;5354.973225133869;5539.612227144102;5545.3622833374275;5552.944470555303;4841.8621623918525;5446.91829622556;5495.313085864267;5523.364813046511;5547.195656629807;5314.548263397616;5443.673379597197;5461.208124821918;5482.890342193134;5493.423190564973;4934.235193544971;5590.385057643656;6103.450689437927;6142.815715528542;6157.507399408037;5710.714464276811;6298.433141017331;6306.968465157691;6311.905321420182;6323.74705011799;6507.414332710032;6529.2164940207;6535.183102112236;6546.6726663667105;6570.310117437696;6188.969055154786;6232.220972378453;6236.314005459396;6253.624782513064;6278.560500764994;6359.713812878432;6410.326915673881;6552.3775241352;6622.072909792633;6662.067310576524;6030.577859549877;6353.777617783448;6363.236411630634;6372;6411.935880641227;5345.866353341197;6466.515011374166;6490.740370385226;6492.707828147744;6522.21733391996;6271.749130034747;6279.811605651837;6293.433590976742;6386.904196437057;6390.105385246069;6266.154069200599;6294.087357333253;6324.747010119636;6403.4877209824035;6424.453921416639;5090.134677104901;5143.819966301162;5158.252053452228;5192.636515443883;5214.061468935628;4616.053708989649;4629.375034370384;4631.861044168681;4652.95347046532;4682.274247491576;5904.409559044061;5965.880682386415;6037.9396206038255;6067.939320606825;6186.350433204449;6325.5255855811;6390.9360906391275;6420;6463;6486.805395838132;6102.4507794298725;6149.2620885494025;6156.815295541141;6160.845978850475;6163.506919446433;5553.500184983371;5728.856778580569;5742.626729262584;5753.4821866031425;5775.768969241183;6484.773032943919;6553.082568440327;6572.14562106923;6629.602223866584;6633.568818026813;6425.389587989321;6505.089287499659;6511.2512061113575;6533.248676402084;6558.672066396756;6610.3720146586;6680.63256520896;6695.631740254333;6706.161729783777;6729.495287853332;6056.636601803906;6263.6241825490615;6288.308286088618;6332.683365831598;6363.331850155852;6501.9674901625185;6510.576812507172;6511.902321465087;6539.247986481616;6560.704768285344;5287.339082614673;6117.632942023492;6284.685765711788;6305.464035557029;6328.46208072319;6232.5637205397;6242.500599952084;6254.781082662085;6284.088807123033;6337.461315788025;6088.756449741961;6288.496920246461;6296.433321001132;6304.810855674337;6309.305976342691;5325.121354976541;5868.882622347443;6081.969590152021;6348.301686814539;6362.745490180341;4676.345311656303;5010.724410157476;6198.938010620016;6243.469305108935;6271.937280627135 02:03:47 INFO - PROCESS | 1653 | |1;ext.html;749.3705287558449;806.8386322735453;828.714093637695;932.9486878221703;963.9421634701914;32344;38694;40571.59428405715;40595.98510037243;40665.39001914974;39670;39794.40308395369;39893.60106398935;39905.20189596206;39979.200415991734;7826.334761545276;8007.399445041616;10483.21375896807;10863.782724345509;10984.945075274652;10703.892961070367;10797;10814.78370432591;10836.403997780119;10844.67465976022;10813.08088812448;10833;10836.07893329068;10866.836997445005;10877.945610271938;10767.300125491818;10774.78450430991;10816.72958176044;10819.67540973772;10839.403832789194;9808.31341806074;9968.70093897177;10604.575816967312;10684.839727404094;10685.893141068645;34974.650253497646;35063.474047889045;35096.947091587295;35142.64857351445;35221;3239.2549713565777;3678.2091850252054;3749.625037496256;3761.37937240355;3796.90507737306;24680.876595617086;25200.87399563009;25297.49405011908;26117.216483505334;26843.19470415891;3110.440120778259;3114.9065528034193;3147.464930961742;3148.1185268124964;3250.431174544469;317372;354633;374068.99999999726;374799;427493;34549.309013819584;42300.57699423028;42508.57491425108;42769.57230427718;42784.3582346265;45022.77488612536;45128;45429.77285113553;45500.77249613731;45686.77156614196;13598.388072536562;13661.453541858215;13686.65783355424;13687.863121368859;13721;11904.047676185884;12051.517939282507;12061;12084.274943503418;12111.515539378326;11748.765024699629;11817.763644727058;11845.644630661094;11887.762244755057;11948.701282467833;4733.810647574127;5573.470520300565;5617.354004289559;5627.127795191752;5632.225848857597;1077.4484741971537;1104.4919337104861;1124.6728859945179;1137.221003612528;1173.372245848467;23687.407814804767;24476.388090297885;26398.86800565985;26587.46825063488;26621.068262611105;1222.8349172861729;1252.949882004728;1254.9309787961568;1268.9619311420672;1272.335673261021;13709.520166794315;13802.516911908035;13835.446582136601;13898.444062237599;13943.233122178175;155109;199168.00415997827;199655;200252;200512;55399;55476.722616387466;55588;55684;55906;1404.908680935736;1456.477980510348;1458.562431270636;1461.5615315405337;1463.985360146385;20148.7761958086;20686.689699654216;24414.877925610257;24903.377415564755;25627.48745025052;45600.54399455963;45607.31589026233;45778.54221457743;45797.77101114473;45837.85405364892;359485;378224;379238.10380947916;380776;381062;29821.10536683903;30398.696013039586;30531.931382401508;30554.388912221188;30596.541051883793;41110.38334425046;41420.1715965685;42624.5737542633;42695.78652106844;42786.78606606947;34484.82757586196;34496.827515862264;34527.82736086303;34786;35508.28983420265;29437.26406839846;32745.34509309848;34884.651153489154;35619.10952226215;35997.82001089978;33220.50169247512;34085.65914340825;35379.82310088433;35539.11152221215;35637.75267865612;21645.783542164376;30372.392552149275;30577.388452231276;30636.791865014722;30852.845735771178;22992.310230693107;23350.76649233486;23566;23576.410589735395;23623.40941476477 02:03:47 INFO - PROCESS | 1653 | |2;jquery.html;412.95251046129664;415.57403661247236;425.1985008259431;432.0847118547188;437.0276135598293;18505.35231266904;19624.90187549062;20915.581688366223;20941;21018.369448916557;20705.275315363964;20829.06269217885;21075.367738967816;21202.363929082112;21383.35849924501;6461.483081353481;6701.061851340792;6702.229243636995;6718.462522998173;6752;5579.9163012554845;6442.420182183602;6622.867542649168;6684.532082754209;6706.664666766642;6612.07430959666;6679.499037572177;6687.230968438643;6687.364700353459;6704.296048914867;6339.619622822623;6662.43369313604;6676.766313179064;6680.699368528428;6689.866202675944;5531.225628412026;6187.257529096537;6479.514036447285;6493.253275873288;6511.827870983221;25258.115965941288;25498;25605.359866003313;25743.356416089562;25858.189926705138;2851.401205746775;2895.4643390972738;2963.1703123125344;2992.7605791536844;3079.0916679579577;15210.771838422432;15821.446249381217;16019.759703604455;16288.661852972644;16529.925554838897;1461.9342129604192;1649.488658515864;1681.8065922418957;1688.5272123805355;1736.9913150434168;120451;122536;124683;125429;127383;18166.818331816776;20183.596328073356;20353.371730261544;21485;21751;26276;32186;32193.51709724356;32826;32832;9110.088991100969;10618.628348007782;10711.08955738771;10900.400477973788;11026.338419694845;8836.823263534694;8970.686025989058;9016.459012459274;9125.634974601075;9206.26349892007;8331.33349332052;10021.899781002243;10094.848577271347;10151.695449136538;10321.277510574188;3612.6026137124895;4222.556631553704;4278.55075217104;4300.376445415397;4324.2648749712;1049.8267785815408;1061.5647584490323;1069.1233188785122;1078.5200585739271;1118.5637601335322;18297.634047319247;18732;20247.797522024885;20802.895985519976;21871.234506792505;1107.5569772091067;1110.2894147745449;1110.6445937299986;1129.2603344809163;1137.7440075983004;11584.594539191088;11784.823227651592;11793.587224447274;11795.823062654066;11856.170068095324;633913;649704;656421;718089;760807.1959640166;133066.00400993993;140117.29941350227;142167.28916355353;144342;157300;1204.6747378207835;1227.1961864978452;1284.3514025417105;1285.3380509037852;1287.523616261989;16873.662526749642;18829.34097306588;19213.711794323375;19543.413697589094;19598.8040119597;43680;52794.68013299698;60403.69798150981;67462;67639;69095.3090469109;69821;83053.16946830455;85756.71364929406;91639;8655.956720216358;9156;10822.512986915764;11120.777584448104;11571.594994175164;12797.552085676956;12823.230606163661;12833.294168820432;13097.67255818574;13147.408366623333;10491.737706557396;10823.701155861347;11311.377874216998;11349.205555611357;11409.144314176305;9268.258539316974;10865.130789536975;11021.173411994292;11215.1027917768;11234.775304493702;11353.148513861659;11368.317900925971;11611.419429028683;11665.35840528779;11702.239354441934;9118.270538356783;11210.66368008961;11412.31526108436;11657.18399712012;11669.824952625888;10847.945760271148;11006.944965275123;11078.169137314573;11094.778104438028;11227.607033754106 02:03:47 INFO - PROCESS | 1653 | |3;mootools.html;1373.5535950815984;1532.2109113806391;1536.9308381122848;1551.8603325700685;1576.3379380660122;10612.363258204503;10985.780284394328;11173.10615150788;11181.608643697473;11286.604968826092;10975.451227438636;11145.888541114586;11153.888461115386;11163.330200187975;11218.99029087382;2394.688690470241;2418.4316685578874;2425.19968410425;2428.453597940458;2431.6352547117986;2369.857808531485;2389.104085967762;2397.9040838366445;2411.927642170729;2412.3486658602255;2362.433016076138;2384.9642255366184;2385.6779334789753;2388.0209114263157;2398.568257713611;2336.8714720690355;2347.4600841806396;2356.7643235676383;2357.0689577616918;2362.0551779288335;2024.1903238704488;2331.63859601762;2364.5152743687677;2394.0902457066204;2396.436837343223;10971.506282217319;11184.944075279653;11209.383483908381;11226.66320010401;11233.775324493547;5869.236999190078;6044.335123136451;6046.00240960241;6064.090386442025;6066.514678825683;3554.253606742587;3702.407614781622;3731.738778285521;3738.7943663098517;3763.473113764075;1184.78673838709;1191.4697959408068;1232.8705485923938;1262.0156278103095;1263.6272299671618;10694.251402401835;11358.886411135865;11449.771004579861;12319.568815091518;13908.026438149334;4499.167653983958;4633.582977532038;4784.2823576463115;4790.4969978152485;4807.879803004953;11486.42567871603;11557.76884462306;11580.826287605692;11583.305001699924;11700.648980530597;5732.398098199629;5746.655200687972;5750.396208398058;5756.884862302731;5757.65454072757;5225.869353266199;5269.499397557226;5280.6303558750515;5321.840344789663;5379.354477462652;3876.1666241758157;3954.130091379892;3972.8410863565714;4039.0508230565792;4048.3117869962175;1060.6923992042375;1061.5223149582564;1064.0583083970587;1074.978500429987;1082.4641802307751;809.9028116626042;858.8754630578532;901.6844104563351;905.610587447404;925.2782829393084;5670.631408958405;5832.620879642895;6767.966160169168;7127.287271272935;7209.71161153548;813.4387272781762;945.0313428735464;1020.8213562626511;1021.4280003198232;1063.8297872340388;3826.521684789401;4145.150244199932;4270.935935960963;4388.319810429389;4398.56014398564;13524;13907.930460347634;13924;13931.512397066053;13986.090904091201;13356;13519.594412167651;13743.106698064794;13852;13900.304984750723;9815.11663950248;9951.701448956543;10107.54516046765;10298.639547615798;10333.48332583383;6519.674016299071;6550.443212327005;6550.868982620416;6595.373439523238;6654.700538475683;11856.70358241051;12039.578614748441;12211.511539538318;12325.815112773136;12432.440540175532;12112.939435302767;12207.38963051826;12263.38683065861;12387.938060309642;12436.440360183633;9034.593443294936;9189.310801689766;9323.86014209801;9342.766430839012;9359.485228312507;9581.137697607248;9601;9616.038396160608;9683.612655493984;9693.806123877624;8949.32880034013;9079.319051071065;9173.082691730773;9231.399959002643;9352.67265645699;8798.340124490816;8845.69040083594;8897.91102088971;8972.955135224282;9032.86450703227;7735.574543400167;7864.410169237216;7897.486663367093;7911.723089692064;7912.32745216663;4954.355933728736;5745;5778.566607504538;5916.083007133729;6000.849978750566;4679.812807487799;5746.942530574808;5874.911876321944;5966.134910438049;6140.20177376956 02:03:47 INFO - PROCESS | 1653 | |4;prototype.html;343.88995521433134;360.7068658857994;367.5185506985849;377.55448570686593;380.7867594147276;4381.649468042557;4710.74090924999;4980.477049909757;5341.1988201769655;5379.865503362408;4349.913001739963;5017.347744793181;5037.093323201822;5210.55710264627;5267.26258323835;4164.937525937114;4274.893127671802;4306.12683482686;4309.6336811371075;4358.585934336233;3707.3697471429787;3864.86472973446;3951.802409879509;4104.6716262699065;4360.411344468504;4046.5953404659595;4319.956800431987;4343.153085148398;4381.496127945279;4385.736855788647;3583.8208089595414;3984.9402258965993;4082.5183585100176;4247.532771395144;4350.564943505656;3568.7145028397927;3965.0087478130467;3982.900427489307;3996.660283875845;4006.659433948089;4987.6758010729545;5072.492750724935;5118.309028281172;5129.974350128263;5160.793568257265;4277.97861010696;4690.366800481926;5007.198848184273;5085.974570127126;5107;5194.870128246786;5452.04589196889;5549.667019978814;5587.664740115565;5649.4633009864;3862.478565393664;3926.9986153530667;4477.306017567283;4503.211937910853;4520.5253448387775;5666.603337766358;5886.528367908023;5913.763449462016;5935.91096133554;6043.91209582275;4053.8986525337104;4129.6489798367475;4393.956060439355;4456.501646207711;4574.794134263966;4480.439945006874;4646.674732768742;4669.696469729457;4672.57946784791;4696.671233013724;4155.444401692937;4878.3406461907225;4883.243097319921;4981.32752078472;5026.547610715053;4939.851804445872;5541.032933308698;5573.247611572386;5576.330840299109;5577.553795696334;1381.5233744358181;1507.8588404465686;1560.680060587577;1595.755310857533;1595.8882878198647;979.0894468144694;1016.8661941934689;1108.1190453589415;1197.706561892342;1198.4427241332821;4623.976880115578;5034.6727462715535;5034.974825125924;5195.922061169085;5251.36983561975;5311.362636483569;5516.475934786269;5795.391483894215;5851.61964472308;5868.530517558585;4066.9222655996186;4504.234280172379;4738.336632871401;4847.854564363075;5262.368515778055;2835.1854812919746;2957.4085182963495;3043.7260646541918;3076.6000419945262;3079.629564843623;5702.914456283159;5938.972347615927;5996.67018313997;6015.849603759941;6163.84590385244;5357.973210133924;5673.574481913873;5677;5843.737031833492;5996.141196229183;5295.6822590643915;5306.230596563477;5365.222042803772;5821.476067153976;5949.553783466171;5216.452272511332;5361.236670579221;5847.544031506863;5900.793472228452;5912.73392697321;5306.399864066657;5438.314122621841;5575;5775.768969241183;5838.649681019152;5041.899162016813;5313.707746073848;5957.344692083954;6022.759089636365;6054.39456054391;3981.1639555693628;4073.7555746655294;4312.310030395121;4553.817847286204;4672.696274742131;4921.803127874845;5022.639359501029;5142.537171654569;5796.478316951495;5917.792877249448;4887.43794463627;5386;5503.3395992481155;5521.4478552144465;5552;5456.772226249062;5647;5665.858353541194;5676.105186354906;5764.59647824665;4820.228763397839;5068.046923399754;5222.947770522398;5339.46605339463;5432.918506222489;5153.7165455898785;5446.428125046813;5604.935062338142;5666.518345940642;5690.0611399120335;4606.493285738499;4751.524847515221;4949.851504454872;5111;5548.55611551083 02:03:47 INFO - PROCESS | 1653 | |5;yui.html;710.733474946895;720.6036679826097;749.8537785131895;761.5659074327635;825.4799476329913;14639.560813175609;15455.768163477556;15649;15666.921665391686;15732.921335393321;14650.853491465083;15284.923575382136;15307.234638268097;15327.233638318095;15351.92324038381;916.0381599320704;943.367943477868;943.7687766497218;945.3146468810093;946.9952650236739;924.3575714878162;947.8436058050413;949.9952500237524;951.2295041016764;953.3993584042079;1006.1196453103535;1019.1948360794963;1020.9336393134422;1021.4637315409433;1022.8465730140464;991.8660980767576;1010.3584224017728;1011.726833754882;1013.989860101397;1014.2747935226348;624.3912185619031;749.0225256040865;751.4702134994816;751.579115695207;753.8153152477623;15539.300731466998;16026.839731602651;16078.919605402016;16322.347106115742;16604.50186494407;14032.228227447486;14151.221682807442;14234.501792437319;14365.281735913162;14384.35270412834;11649.70875728105;11805.822912656316;11812.11409144309;11816.231944923553;11894.345810980392;3312.3540909522653;3646.5624125105155;3684.244729830405;3707.776433776847;3708.7774733515807;82001.58999205026;96626.03373966241;100502;100845.99154008439;101370.49314753452;10306.433146177033;10656.307340022873;10745.731356715989;10846.18653600983;10881.945590271998;18720.719189212174;22471.775282246967;22676.433089172573;22847.543049139258;22880.542389152124;7701.576413297211;7726.9613651932505;7728;7873.1733168016535;7978.3218426434405;4273.658107351404;4311.396404503372;4389.209942210433;4406.845760398371;4429;3522.2427178156818;3564.1446052947626;3602.1715005548344;3623.4927110204594;3633.781973081571;649.0880313160018;651.1665068712056;653.2748648999607;657.947364210862;659.152988409891;611.8806832667676;655.6557807151283;663.3912761553214;671.8891382921763;694.3889377347901;9896.356736812084;10165.94917025425;10226.181905447545;10331.535080921376;10357.482125893675;563.2452513631671;615.9137720719103;616.824205101544;642.7429028388589;701.0525690408032;4657.3246879202325;5005.1241032819835;5134.768935397916;5135.306733590917;5137.8201762938115;100183;102222;102314.48842755739;103071.96928030624;105673.94326056795;51322.74338628283;65800.34199658038;70764;79391;80792;71263.64368178126;72573;74337.25662743411;75156.62421687857;75987.24012759802;10878.564857405616;11103.5558577656;11129.610463633733;11243.381614011309;11374.886251137383;37019;39449.60550394459;50056.74971625264;50572;52217.47782522126;64363.034554480786;64664;65896.67051664711;67391.66304168447;67506.31234218988;10264.692059238234;12641.93679031599;12781.16922400041;12899.921942197347;13010.21938683682;14370.712585748435;14389.496367627084;14400.711985760436;14560.781588275973;15318.157501337533;11168.944155279172;13036.674083147996;13505.729885402041;13837.723245534831;13888.166709997433;13381.732365352444;13640.795388069386;13805.930970345084;13841.792373114613;13869.09850859691;12241.571544995883;12815.359232038547;13164.934175329063;13595.456181753014;13844.653883652989;10899.673009809718;10908.61819836302;11087;11090.944545277545;11530.365829879438;10476.79046419052;10677.199210059121;11041.516822504826;11432.771344572895;11922.880771192524 02:03:47 INFO - PROCESS | 1653 | __end_tp_report 02:03:47 INFO - PROCESS | 1653 | __start_cc_report 02:03:47 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,411 02:03:47 INFO - PROCESS | 1653 | __end_cc_report 02:03:47 INFO - PROCESS | 1653 | __startTimestamp1489395827281__endTimestamp 02:03:47 INFO - PROCESS | 1653 | 02:03:47 INFO - PROCESS | 1653 | ------- Summary: start ------- 02:03:47 INFO - PROCESS | 1653 | Number of tests: 6 02:03:47 INFO - PROCESS | 1653 | 02:03:47 INFO - PROCESS | 1653 | [#0] dojo.html Cycles:165 Average:5942.87 Median:6188.97 stddev:685.62 (11.1%) stddev-sans-first:659.95 02:03:47 INFO - PROCESS | 1653 | Values: 3480.5 3500.7 3507.0 3511.9 3518.3 6077.5 6080.0 6084.9 6105.5 6116.0 5961.3 6030.7 6054.6 6108.9 6137.8 5424.3 5487.7 5491.0 5494.0 5580.2 3907.4 5545.6 5572.4 5576.6 5618.3 5350.2 5355.0 5539.6 5545.4 5552.9 4841.9 5446.9 5495.3 5523.4 5547.2 5314.5 5443.7 5461.2 5482.9 5493.4 4934.2 5590.4 6103.5 6142.8 6157.5 5710.7 6298.4 6307.0 6311.9 6323.7 6507.4 6529.2 6535.2 6546.7 6570.3 6189.0 6232.2 6236.3 6253.6 6278.6 6359.7 6410.3 6552.4 6622.1 6662.1 6030.6 6353.8 6363.2 6372.0 6411.9 5345.9 6466.5 6490.7 6492.7 6522.2 6271.7 6279.8 6293.4 6386.9 6390.1 6266.2 6294.1 6324.7 6403.5 6424.5 5090.1 5143.8 5158.3 5192.6 5214.1 4616.1 4629.4 4631.9 4653.0 4682.3 5904.4 5965.9 6037.9 6067.9 6186.4 6325.5 6390.9 6420.0 6463.0 6486.8 6102.5 6149.3 6156.8 6160.8 6163.5 5553.5 5728.9 5742.6 5753.5 5775.8 6484.8 6553.1 6572.1 6629.6 6633.6 6425.4 6505.1 6511.3 6533.2 6558.7 6610.4 6680.6 6695.6 6706.2 6729.5 6056.6 6263.6 6288.3 6332.7 6363.3 6502.0 6510.6 6511.9 6539.2 6560.7 5287.3 6117.6 6284.7 6305.5 6328.5 6232.6 6242.5 6254.8 6284.1 6337.5 6088.8 6288.5 6296.4 6304.8 6309.3 5325.1 5868.9 6082.0 6348.3 6362.7 4676.3 5010.7 6198.9 6243.5 6271.9 02:03:47 INFO - PROCESS | 1653 | 02:03:47 INFO - PROCESS | 1653 | [#1] ext.html Cycles:180 Average:46129.75 Median:30744.82 stddev:85774.74 (279.0%) stddev-sans-first:85947.69 02:03:47 INFO - PROCESS | 1653 | Values: 749.4 806.8 828.7 932.9 963.9 32344.0 38694.0 40571.6 40596.0 40665.4 39670.0 39794.4 39893.6 39905.2 39979.2 7826.3 8007.4 10483.2 10863.8 10984.9 10703.9 10797.0 10814.8 10836.4 10844.7 10813.1 10833.0 10836.1 10866.8 10877.9 10767.3 10774.8 10816.7 10819.7 10839.4 9808.3 9968.7 10604.6 10684.8 10685.9 34974.7 35063.5 35096.9 35142.6 35221.0 3239.3 3678.2 3749.6 3761.4 3796.9 24680.9 25200.9 25297.5 26117.2 26843.2 3110.4 3114.9 3147.5 3148.1 3250.4 317372.0 354633.0 374069.0 374799.0 427493.0 34549.3 42300.6 42508.6 42769.6 42784.4 45022.8 45128.0 45429.8 45500.8 45686.8 13598.4 13661.5 13686.7 13687.9 13721.0 11904.0 12051.5 12061.0 12084.3 12111.5 11748.8 11817.8 11845.6 11887.8 11948.7 4733.8 5573.5 5617.4 5627.1 5632.2 1077.4 1104.5 1124.7 1137.2 1173.4 23687.4 24476.4 26398.9 26587.5 26621.1 1222.8 1252.9 1254.9 1269.0 1272.3 13709.5 13802.5 13835.4 13898.4 13943.2 155109.0 199168.0 199655.0 200252.0 200512.0 55399.0 55476.7 55588.0 55684.0 55906.0 1404.9 1456.5 1458.6 1461.6 1464.0 20148.8 20686.7 24414.9 24903.4 25627.5 45600.5 45607.3 45778.5 45797.8 45837.9 359485.0 378224.0 379238.1 380776.0 381062.0 29821.1 30398.7 30531.9 30554.4 30596.5 41110.4 41420.2 42624.6 42695.8 42786.8 34484.8 34496.8 34527.8 34786.0 35508.3 29437.3 32745.3 34884.7 35619.1 35997.8 33220.5 34085.7 35379.8 35539.1 35637.8 21645.8 30372.4 30577.4 30636.8 30852.8 22992.3 23350.8 23566.0 23576.4 23623.4 02:03:47 INFO - PROCESS | 1653 | 02:03:47 INFO - PROCESS | 1653 | [#2] jquery.html Cycles:180 Average:39658.16 Median:20300.58 stddev:113933.36 (561.2%) stddev-sans-first:114214.86 02:03:47 INFO - PROCESS | 1653 | Values: 413.0 415.6 425.2 432.1 437.0 18505.4 19624.9 20915.6 20941.0 21018.4 20705.3 20829.1 21075.4 21202.4 21383.4 6461.5 6701.1 6702.2 6718.5 6752.0 5579.9 6442.4 6622.9 6684.5 6706.7 6612.1 6679.5 6687.2 6687.4 6704.3 6339.6 6662.4 6676.8 6680.7 6689.9 5531.2 6187.3 6479.5 6493.3 6511.8 25258.1 25498.0 25605.4 25743.4 25858.2 2851.4 2895.5 2963.2 2992.8 3079.1 15210.8 15821.4 16019.8 16288.7 16529.9 1461.9 1649.5 1681.8 1688.5 1737.0 120451.0 122536.0 124683.0 125429.0 127383.0 18166.8 20183.6 20353.4 21485.0 21751.0 26276.0 32186.0 32193.5 32826.0 32832.0 9110.1 10618.6 10711.1 10900.4 11026.3 8836.8 8970.7 9016.5 9125.6 9206.3 8331.3 10021.9 10094.8 10151.7 10321.3 3612.6 4222.6 4278.6 4300.4 4324.3 1049.8 1061.6 1069.1 1078.5 1118.6 18297.6 18732.0 20247.8 20802.9 21871.2 1107.6 1110.3 1110.6 1129.3 1137.7 11584.6 11784.8 11793.6 11795.8 11856.2 633913.0 649704.0 656421.0 718089.0 760807.2 133066.0 140117.3 142167.3 144342.0 157300.0 1204.7 1227.2 1284.4 1285.3 1287.5 16873.7 18829.3 19213.7 19543.4 19598.8 43680.0 52794.7 60403.7 67462.0 67639.0 69095.3 69821.0 83053.2 85756.7 91639.0 8656.0 9156.0 10822.5 11120.8 11571.6 12797.6 12823.2 12833.3 13097.7 13147.4 10491.7 10823.7 11311.4 11349.2 11409.1 9268.3 10865.1 11021.2 11215.1 11234.8 11353.1 11368.3 11611.4 11665.4 11702.2 9118.3 11210.7 11412.3 11657.2 11669.8 10847.9 11006.9 11078.2 11094.8 11227.6 02:03:47 INFO - PROCESS | 1653 | 02:03:47 INFO - PROCESS | 1653 | [#3] mootools.html Cycles:180 Average:6649.85 Median:2992.94 stddev:4070.44 (136.0%) stddev-sans-first:4062.55 02:03:47 INFO - PROCESS | 1653 | Values: 1373.6 1532.2 1536.9 1551.9 1576.3 10612.4 10985.8 11173.1 11181.6 11286.6 10975.5 11145.9 11153.9 11163.3 11219.0 2394.7 2418.4 2425.2 2428.5 2431.6 2369.9 2389.1 2397.9 2411.9 2412.3 2362.4 2385.0 2385.7 2388.0 2398.6 2336.9 2347.5 2356.8 2357.1 2362.1 2024.2 2331.6 2364.5 2394.1 2396.4 10971.5 11184.9 11209.4 11226.7 11233.8 5869.2 6044.3 6046.0 6064.1 6066.5 3554.3 3702.4 3731.7 3738.8 3763.5 1184.8 1191.5 1232.9 1262.0 1263.6 10694.3 11358.9 11449.8 12319.6 13908.0 4499.2 4633.6 4784.3 4790.5 4807.9 11486.4 11557.8 11580.8 11583.3 11700.6 5732.4 5746.7 5750.4 5756.9 5757.7 5225.9 5269.5 5280.6 5321.8 5379.4 3876.2 3954.1 3972.8 4039.1 4048.3 1060.7 1061.5 1064.1 1075.0 1082.5 809.9 858.9 901.7 905.6 925.3 5670.6 5832.6 6768.0 7127.3 7209.7 813.4 945.0 1020.8 1021.4 1063.8 3826.5 4145.2 4270.9 4388.3 4398.6 13524.0 13907.9 13924.0 13931.5 13986.1 13356.0 13519.6 13743.1 13852.0 13900.3 9815.1 9951.7 10107.5 10298.6 10333.5 6519.7 6550.4 6550.9 6595.4 6654.7 11856.7 12039.6 12211.5 12325.8 12432.4 12112.9 12207.4 12263.4 12387.9 12436.4 9034.6 9189.3 9323.9 9342.8 9359.5 9581.1 9601.0 9616.0 9683.6 9693.8 8949.3 9079.3 9173.1 9231.4 9352.7 8798.3 8845.7 8897.9 8973.0 9032.9 7735.6 7864.4 7897.5 7911.7 7912.3 4954.4 5745.0 5778.6 5916.1 6000.8 4679.8 5746.9 5874.9 5966.1 6140.2 02:03:47 INFO - PROCESS | 1653 | 02:03:47 INFO - PROCESS | 1653 | [#4] prototype.html Cycles:180 Average:4641.37 Median:5030.61 stddev:1312.99 (26.1%) stddev-sans-first:1276.44 02:03:47 INFO - PROCESS | 1653 | Values: 343.9 360.7 367.5 377.6 380.8 4381.6 4710.7 4980.5 5341.2 5379.9 4349.9 5017.3 5037.1 5210.6 5267.3 4164.9 4274.9 4306.1 4309.6 4358.6 3707.4 3864.9 3951.8 4104.7 4360.4 4046.6 4320.0 4343.2 4381.5 4385.7 3583.8 3984.9 4082.5 4247.5 4350.6 3568.7 3965.0 3982.9 3996.7 4006.7 4987.7 5072.5 5118.3 5130.0 5160.8 4278.0 4690.4 5007.2 5086.0 5107.0 5194.9 5452.0 5549.7 5587.7 5649.5 3862.5 3927.0 4477.3 4503.2 4520.5 5666.6 5886.5 5913.8 5935.9 6043.9 4053.9 4129.6 4394.0 4456.5 4574.8 4480.4 4646.7 4669.7 4672.6 4696.7 4155.4 4878.3 4883.2 4981.3 5026.5 4939.9 5541.0 5573.2 5576.3 5577.6 1381.5 1507.9 1560.7 1595.8 1595.9 979.1 1016.9 1108.1 1197.7 1198.4 4624.0 5034.7 5035.0 5195.9 5251.4 5311.4 5516.5 5795.4 5851.6 5868.5 4066.9 4504.2 4738.3 4847.9 5262.4 2835.2 2957.4 3043.7 3076.6 3079.6 5702.9 5939.0 5996.7 6015.8 6163.8 5358.0 5673.6 5677.0 5843.7 5996.1 5295.7 5306.2 5365.2 5821.5 5949.6 5216.5 5361.2 5847.5 5900.8 5912.7 5306.4 5438.3 5575.0 5775.8 5838.6 5041.9 5313.7 5957.3 6022.8 6054.4 3981.2 4073.8 4312.3 4553.8 4672.7 4921.8 5022.6 5142.5 5796.5 5917.8 4887.4 5386.0 5503.3 5521.4 5552.0 5456.8 5647.0 5665.9 5676.1 5764.6 4820.2 5068.0 5222.9 5339.5 5432.9 5153.7 5446.4 5604.9 5666.5 5690.1 4606.5 4751.5 4949.9 5111.0 5548.6 02:03:47 INFO - PROCESS | 1653 | 02:03:47 INFO - PROCESS | 1653 | [#5] yui.html Cycles:180 Average:19493.11 Median:17662.61 stddev:27097.06 (153.4%) stddev-sans-first:27136.38 02:03:47 INFO - PROCESS | 1653 | Values: 710.7 720.6 749.9 761.6 825.5 14639.6 15455.8 15649.0 15666.9 15732.9 14650.9 15284.9 15307.2 15327.2 15351.9 916.0 943.4 943.8 945.3 947.0 924.4 947.8 950.0 951.2 953.4 1006.1 1019.2 1020.9 1021.5 1022.8 991.9 1010.4 1011.7 1014.0 1014.3 624.4 749.0 751.5 751.6 753.8 15539.3 16026.8 16078.9 16322.3 16604.5 14032.2 14151.2 14234.5 14365.3 14384.4 11649.7 11805.8 11812.1 11816.2 11894.3 3312.4 3646.6 3684.2 3707.8 3708.8 82001.6 96626.0 100502.0 100846.0 101370.5 10306.4 10656.3 10745.7 10846.2 10881.9 18720.7 22471.8 22676.4 22847.5 22880.5 7701.6 7727.0 7728.0 7873.2 7978.3 4273.7 4311.4 4389.2 4406.8 4429.0 3522.2 3564.1 3602.2 3623.5 3633.8 649.1 651.2 653.3 657.9 659.2 611.9 655.7 663.4 671.9 694.4 9896.4 10165.9 10226.2 10331.5 10357.5 563.2 615.9 616.8 642.7 701.1 4657.3 5005.1 5134.8 5135.3 5137.8 100183.0 102222.0 102314.5 103072.0 105673.9 51322.7 65800.3 70764.0 79391.0 80792.0 71263.6 72573.0 74337.3 75156.6 75987.2 10878.6 11103.6 11129.6 11243.4 11374.9 37019.0 39449.6 50056.7 50572.0 52217.5 64363.0 64664.0 65896.7 67391.7 67506.3 10264.7 12641.9 12781.2 12899.9 13010.2 14370.7 14389.5 14400.7 14560.8 15318.2 11168.9 13036.7 13505.7 13837.7 13888.2 13381.7 13640.8 13805.9 13841.8 13869.1 12241.6 12815.4 13164.9 13595.5 13844.7 10899.7 10908.6 11087.0 11090.9 11530.4 10476.8 10677.2 11041.5 11432.8 11922.9 02:03:47 INFO - PROCESS | 1653 | -------- Summary: end -------- 02:03:47 INFO - PROCESS | 1653 | 02:03:47 INFO - TEST-INFO | 1653: exit 0 02:03:47 INFO - TEST-OK | dromaeo_css | took 1118085ms 02:03:47 INFO - TEST-START | kraken 02:03:47 INFO - operating with platform_type : mac_ 02:03:47 INFO - Initialising browser for kraken test... 02:03:47 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/tmp_6TelX/profile http://localhost:49243/getInfo.html) 02:03:50 INFO - PROCESS | 1662 | 2017-03-13 02:03:50.640 plugin-container[1664:11522] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b43, name = 'com.apple.tsm.portname' 02:03:50 INFO - PROCESS | 1662 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:03:50 INFO - PROCESS | 1662 | 2017-03-13 02:03:50.642 plugin-container[1664:11522] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e23, name = 'com.apple.CFPasteboardClient' 02:03:50 INFO - PROCESS | 1662 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:03:50 INFO - PROCESS | 1662 | 2017-03-13 02:03:50.642 plugin-container[1664:11522] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:03:50 INFO - PROCESS | 1662 | __metrics Screen width/height:1600/1200 02:03:50 INFO - PROCESS | 1662 | colorDepth:24 02:03:50 INFO - PROCESS | 1662 | Browser inner width/height: 1024/689 02:03:50 INFO - PROCESS | 1662 | __metrics 02:03:50 ERROR - PROCESS | 1662 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3353: TypeError: this.tabs is undefined 02:03:51 INFO - TEST-INFO | 1662: exit 0 02:03:51 INFO - Browser initialized. 02:03:51 INFO - Running cycle 1/1 for kraken test... 02:03:51 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/tmp_6TelX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:03:54 INFO - PROCESS | 1665 | 2017-03-13 02:03:54.205 plugin-container[1666:11658] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4643, name = 'com.apple.tsm.portname' 02:03:54 INFO - PROCESS | 1665 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:03:54 INFO - PROCESS | 1665 | 2017-03-13 02:03:54.205 plugin-container[1666:11658] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 02:03:54 INFO - PROCESS | 1665 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:03:54 INFO - PROCESS | 1665 | 2017-03-13 02:03:54.205 plugin-container[1666:11658] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:04:03 INFO - PROCESS | 1665 | RSS: Main: 220352512 02:04:03 INFO - PROCESS | 1665 | 02:04:06 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection) 02:04:07 INFO - PROCESS | 1665 | RSS: Main: 234901504 02:04:07 INFO - PROCESS | 1665 | 02:04:10 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-dft) 02:04:11 INFO - PROCESS | 1665 | RSS: Main: 243101696 02:04:11 INFO - PROCESS | 1665 | 02:04:14 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-fft) 02:04:15 INFO - PROCESS | 1665 | RSS: Main: 246968320 02:04:15 INFO - PROCESS | 1665 | 02:04:17 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator) 02:04:17 INFO - PROCESS | 1665 | RSS: Main: 248188928 02:04:17 INFO - PROCESS | 1665 | 02:04:19 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:04:20 INFO - PROCESS | 1665 | RSS: Main: 248545280 02:04:20 INFO - PROCESS | 1665 | 02:04:23 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom) 02:04:24 INFO - PROCESS | 1665 | RSS: Main: 252416000 02:04:24 INFO - PROCESS | 1665 | 02:04:27 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate) 02:04:28 INFO - PROCESS | 1665 | RSS: Main: 252145664 02:04:28 INFO - PROCESS | 1665 | 02:04:31 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial) 02:04:32 INFO - PROCESS | 1665 | RSS: Main: 249335808 02:04:32 INFO - PROCESS | 1665 | 02:04:34 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:04:34 INFO - PROCESS | 1665 | RSS: Main: 250408960 02:04:34 INFO - PROCESS | 1665 | 02:04:36 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:04:37 INFO - PROCESS | 1665 | RSS: Main: 250773504 02:04:37 INFO - PROCESS | 1665 | 02:04:39 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:04:40 INFO - PROCESS | 1665 | RSS: Main: 251158528 02:04:40 INFO - PROCESS | 1665 | 02:04:43 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:04:43 INFO - PROCESS | 1665 | RSS: Main: 251498496 02:04:43 INFO - PROCESS | 1665 | 02:04:46 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:04:47 INFO - PROCESS | 1665 | RSS: Main: 251252736 02:04:47 INFO - PROCESS | 1665 | 02:04:49 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49243/tests/kraken/driver.html?testName=ai-astar) 02:04:49 INFO - PROCESS | 1665 | RSS: Main: 254861312 02:04:49 INFO - PROCESS | 1665 | 02:04:49 INFO - PROCESS | 1665 | __start_tp_report 02:04:49 INFO - PROCESS | 1665 | _x_x_mozilla_page_load 02:04:49 INFO - PROCESS | 1665 | _x_x_mozilla_page_load_details 02:04:49 INFO - PROCESS | 1665 | |i|pagename|runs| 02:04:49 INFO - PROCESS | 1665 | |0;ai-astar;109;120;122;119;120;119;118;125;114;119 02:04:49 INFO - PROCESS | 1665 | |1;audio-beat-detection;145;113;108;182;146;142;113;114;134;111 02:04:49 INFO - PROCESS | 1665 | |2;audio-dft;207;198;197;199;198;199;202;187;285;250 02:04:49 INFO - PROCESS | 1665 | |3;audio-fft;80;60;76;87;62;55;69;64;74;63 02:04:49 INFO - PROCESS | 1665 | |4;audio-oscillator;88;69;85;74;72;69;85;69;69;84 02:04:49 INFO - PROCESS | 1665 | |5;imaging-gaussian-blur;89;135;103;88;117;87;134;135;89;88 02:04:49 INFO - PROCESS | 1665 | |6;imaging-darkroom;96;97;144;97;110;152;130;98;97;97 02:04:49 INFO - PROCESS | 1665 | |7;imaging-desaturate;89;142;142;105;90;92;127;142;99;92 02:04:49 INFO - PROCESS | 1665 | |8;json-parse-financial;68;66;67;70;68;69;67;69;69;68 02:04:49 INFO - PROCESS | 1665 | |9;json-stringify-tinderbox;59;63;65;59;57;59;59;59;58;59 02:04:49 INFO - PROCESS | 1665 | |10;stanford-crypto-aes;87;87;88;85;86;86;92;87;87;94 02:04:49 INFO - PROCESS | 1665 | |11;stanford-crypto-ccm;150;153;157;149;149;140;141;153;202;177 02:04:49 INFO - PROCESS | 1665 | |12;stanford-crypto-pbkdf2;167;169;200;151;158;227;228;213;222;181 02:04:49 INFO - PROCESS | 1665 | |13;stanford-crypto-sha256-iterative;67;66;66;65;66;67;67;66;74;64 02:04:49 INFO - PROCESS | 1665 | __end_tp_report 02:04:49 INFO - PROCESS | 1665 | __start_cc_report 02:04:49 INFO - PROCESS | 1665 | _x_x_mozilla_cycle_collect,1018 02:04:49 INFO - PROCESS | 1665 | __end_cc_report 02:04:49 INFO - PROCESS | 1665 | __startTimestamp1489395889556__endTimestamp 02:04:49 INFO - PROCESS | 1665 | 02:04:49 INFO - PROCESS | 1665 | ------- Summary: start ------- 02:04:49 INFO - PROCESS | 1665 | Number of tests: 14 02:04:49 INFO - PROCESS | 1665 | 02:04:49 INFO - PROCESS | 1665 | [#0] ai-astar Cycles:10 Average:118.50 Median:119.50 stddev:4.35 (3.6%) stddev-sans-first:2.96 02:04:49 INFO - PROCESS | 1665 | Values: 109.0 120.0 122.0 119.0 120.0 119.0 118.0 125.0 114.0 119.0 02:04:49 INFO - PROCESS | 1665 | 02:04:49 INFO - PROCESS | 1665 | [#1] audio-beat-detection Cycles:10 Average:130.80 Median:138.00 stddev:23.61 (17.1%) stddev-sans-first:24.48 02:04:49 INFO - PROCESS | 1665 | Values: 145.0 113.0 108.0 182.0 146.0 142.0 113.0 114.0 134.0 111.0 02:04:49 INFO - PROCESS | 1665 | 02:04:49 INFO - PROCESS | 1665 | [#2] audio-dft Cycles:10 Average:212.20 Median:200.50 stddev:30.69 (15.3%) stddev-sans-first:32.50 02:04:49 INFO - PROCESS | 1665 | Values: 207.0 198.0 197.0 199.0 198.0 199.0 202.0 187.0 285.0 250.0 02:04:49 INFO - PROCESS | 1665 | 02:04:49 INFO - PROCESS | 1665 | [#3] audio-fft Cycles:10 Average:69.00 Median:71.50 stddev:10.03 (14.0%) stddev-sans-first:9.82 02:04:49 INFO - PROCESS | 1665 | Values: 80.0 60.0 76.0 87.0 62.0 55.0 69.0 64.0 74.0 63.0 02:04:49 INFO - PROCESS | 1665 | 02:04:49 INFO - PROCESS | 1665 | [#4] audio-oscillator Cycles:10 Average:76.40 Median:79.00 stddev:8.06 (10.2%) stddev-sans-first:7.37 02:04:49 INFO - PROCESS | 1665 | Values: 88.0 69.0 85.0 74.0 72.0 69.0 85.0 69.0 69.0 84.0 02:04:49 INFO - PROCESS | 1665 | 02:04:49 INFO - PROCESS | 1665 | [#5] imaging-gaussian-blur Cycles:10 Average:106.50 Median:87.50 stddev:21.55 (24.6%) stddev-sans-first:21.91 02:04:49 INFO - PROCESS | 1665 | Values: 89.0 135.0 103.0 88.0 117.0 87.0 134.0 135.0 89.0 88.0 02:04:49 INFO - PROCESS | 1665 | 02:04:49 INFO - PROCESS | 1665 | [#6] imaging-darkroom Cycles:10 Average:111.80 Median:97.00 stddev:21.87 (22.5%) stddev-sans-first:22.43 02:04:49 INFO - PROCESS | 1665 | Values: 96.0 97.0 144.0 97.0 110.0 152.0 130.0 98.0 97.0 97.0 02:04:49 INFO - PROCESS | 1665 | 02:04:49 INFO - PROCESS | 1665 | [#7] imaging-desaturate Cycles:10 Average:112.00 Median:89.50 stddev:23.47 (26.2%) stddev-sans-first:23.37 02:04:49 INFO - PROCESS | 1665 | Values: 89.0 142.0 142.0 105.0 90.0 92.0 127.0 142.0 99.0 92.0 02:04:49 INFO - PROCESS | 1665 | 02:04:49 INFO - PROCESS | 1665 | [#8] json-parse-financial Cycles:10 Average:68.10 Median:68.50 stddev:1.20 (1.7%) stddev-sans-first:1.27 02:04:49 INFO - PROCESS | 1665 | Values: 68.0 66.0 67.0 70.0 68.0 69.0 67.0 69.0 69.0 68.0 02:04:49 INFO - PROCESS | 1665 | 02:04:49 INFO - PROCESS | 1665 | [#9] json-stringify-tinderbox Cycles:10 Average:59.70 Median:59.00 stddev:2.41 (4.1%) stddev-sans-first:2.54 02:04:49 INFO - PROCESS | 1665 | Values: 59.0 63.0 65.0 59.0 57.0 59.0 59.0 59.0 58.0 59.0 02:04:49 INFO - PROCESS | 1665 | 02:04:49 INFO - PROCESS | 1665 | [#10] stanford-crypto-aes Cycles:10 Average:87.90 Median:87.00 stddev:2.85 (3.3%) stddev-sans-first:3.00 02:04:49 INFO - PROCESS | 1665 | Values: 87.0 87.0 88.0 85.0 86.0 86.0 92.0 87.0 87.0 94.0 02:04:49 INFO - PROCESS | 1665 | 02:04:49 INFO - PROCESS | 1665 | [#11] stanford-crypto-ccm Cycles:10 Average:157.10 Median:153.00 stddev:18.79 (12.3%) stddev-sans-first:19.76 02:04:49 INFO - PROCESS | 1665 | Values: 150.0 153.0 157.0 149.0 149.0 140.0 141.0 153.0 202.0 177.0 02:04:49 INFO - PROCESS | 1665 | 02:04:49 INFO - PROCESS | 1665 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:191.60 Median:206.50 stddev:29.88 (14.5%) stddev-sans-first:30.34 02:04:49 INFO - PROCESS | 1665 | Values: 167.0 169.0 200.0 151.0 158.0 227.0 228.0 213.0 222.0 181.0 02:04:49 INFO - PROCESS | 1665 | 02:04:49 INFO - PROCESS | 1665 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:66.50 stddev:2.70 (4.1%) stddev-sans-first:2.86 02:04:49 INFO - PROCESS | 1665 | Values: 67.0 66.0 66.0 65.0 66.0 67.0 67.0 66.0 74.0 64.0 02:04:49 INFO - PROCESS | 1665 | -------- Summary: end -------- 02:04:49 INFO - PROCESS | 1665 | 02:04:50 INFO - TEST-INFO | 1665: exit 0 02:04:50 INFO - TEST-OK | kraken | took 62489ms 02:04:50 INFO - SUITE-END | took 1180s 02:04:50 INFO - Completed test suite (00:19:40) 02:04:50 INFO - javascript benchmark 02:04:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7622.551932364615, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3480.5301284326615, 3500.719942404608, 3507.0180349502148, 3511.929761404772, 3518.2611651553166, 6077.4530292273685, 6079.969600151993, 6084.878302433955, 6105.511559075275, 6116.0, 5961.284645842494, 6030.66831324277, 6054.636721796695, 6108.877822443548, 6137.785177518787, 5424.321959755031, 5487.6981766002855, 5490.972545137269, 5493.972530137344, 5580.218769372271, 3907.355286377744, 5545.611807173499, 5572.442755724415, 5576.637518561301, 5618.297712785902, 5350.197470379435, 5354.973225133869, 5539.612227144102, 5545.3622833374275, 5552.944470555303, 4841.8621623918525, 5446.91829622556, 5495.313085864267, 5523.364813046511, 5547.195656629807, 5314.548263397616, 5443.673379597197, 5461.208124821918, 5482.890342193134, 5493.423190564973, 4934.235193544971, 5590.385057643656, 6103.450689437927, 6142.815715528542, 6157.507399408037, 5710.714464276811, 6298.433141017331, 6306.968465157691, 6311.905321420182, 6323.74705011799, 6507.414332710032, 6529.2164940207, 6535.183102112236, 6546.6726663667105, 6570.310117437696, 6188.969055154786, 6232.220972378453, 6236.314005459396, 6253.624782513064, 6278.560500764994, 6359.713812878432, 6410.326915673881, 6552.3775241352, 6622.072909792633, 6662.067310576524, 6030.577859549877, 6353.777617783448, 6363.236411630634, 6372.0, 6411.935880641227, 5345.866353341197, 6466.515011374166, 6490.740370385226, 6492.707828147744, 6522.21733391996, 6271.749130034747, 6279.811605651837, 6293.433590976742, 6386.904196437057, 6390.105385246069, 6266.154069200599, 6294.087357333253, 6324.747010119636, 6403.4877209824035, 6424.453921416639, 5090.134677104901, 5143.819966301162, 5158.252053452228, 5192.636515443883, 5214.061468935628, 4616.053708989649, 4629.375034370384, 4631.861044168681, 4652.95347046532, 4682.274247491576, 5904.409559044061, 5965.880682386415, 6037.9396206038255, 6067.939320606825, 6186.350433204449, 6325.5255855811, 6390.9360906391275, 6420.0, 6463.0, 6486.805395838132, 6102.4507794298725, 6149.2620885494025, 6156.815295541141, 6160.845978850475, 6163.506919446433, 5553.500184983371, 5728.856778580569, 5742.626729262584, 5753.4821866031425, 5775.768969241183, 6484.773032943919, 6553.082568440327, 6572.14562106923, 6629.602223866584, 6633.568818026813, 6425.389587989321, 6505.089287499659, 6511.2512061113575, 6533.248676402084, 6558.672066396756, 6610.3720146586, 6680.63256520896, 6695.631740254333, 6706.161729783777, 6729.495287853332, 6056.636601803906, 6263.6241825490615, 6288.308286088618, 6332.683365831598, 6363.331850155852, 6501.9674901625185, 6510.576812507172, 6511.902321465087, 6539.247986481616, 6560.704768285344, 5287.339082614673, 6117.632942023492, 6284.685765711788, 6305.464035557029, 6328.46208072319, 6232.5637205397, 6242.500599952084, 6254.781082662085, 6284.088807123033, 6337.461315788025, 6088.756449741961, 6288.496920246461, 6296.433321001132, 6304.810855674337, 6309.305976342691, 5325.121354976541, 5868.882622347443, 6081.969590152021, 6348.301686814539, 6362.745490180341, 4676.345311656303, 5010.724410157476, 6198.938010620016, 6243.469305108935, 6271.937280627135], "value": 5901.8199258298255, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [749.3705287558449, 806.8386322735453, 828.714093637695, 932.9486878221703, 963.9421634701914, 32344.0, 38694.0, 40571.59428405715, 40595.98510037243, 40665.39001914974, 39670.0, 39794.40308395369, 39893.60106398935, 39905.20189596206, 39979.200415991734, 7826.334761545276, 8007.399445041616, 10483.21375896807, 10863.782724345509, 10984.945075274652, 10703.892961070367, 10797.0, 10814.78370432591, 10836.403997780119, 10844.67465976022, 10813.08088812448, 10833.0, 10836.07893329068, 10866.836997445005, 10877.945610271938, 10767.300125491818, 10774.78450430991, 10816.72958176044, 10819.67540973772, 10839.403832789194, 9808.31341806074, 9968.70093897177, 10604.575816967312, 10684.839727404094, 10685.893141068645, 34974.650253497646, 35063.474047889045, 35096.947091587295, 35142.64857351445, 35221.0, 3239.2549713565777, 3678.2091850252054, 3749.625037496256, 3761.37937240355, 3796.90507737306, 24680.876595617086, 25200.87399563009, 25297.49405011908, 26117.216483505334, 26843.19470415891, 3110.440120778259, 3114.9065528034193, 3147.464930961742, 3148.1185268124964, 3250.431174544469, 317372.0, 354633.0, 374068.99999999726, 374799.0, 427493.0, 34549.309013819584, 42300.57699423028, 42508.57491425108, 42769.57230427718, 42784.3582346265, 45022.77488612536, 45128.0, 45429.77285113553, 45500.77249613731, 45686.77156614196, 13598.388072536562, 13661.453541858215, 13686.65783355424, 13687.863121368859, 13721.0, 11904.047676185884, 12051.517939282507, 12061.0, 12084.274943503418, 12111.515539378326, 11748.765024699629, 11817.763644727058, 11845.644630661094, 11887.762244755057, 11948.701282467833, 4733.810647574127, 5573.470520300565, 5617.354004289559, 5627.127795191752, 5632.225848857597, 1077.4484741971537, 1104.4919337104861, 1124.6728859945179, 1137.221003612528, 1173.372245848467, 23687.407814804767, 24476.388090297885, 26398.86800565985, 26587.46825063488, 26621.068262611105, 1222.8349172861729, 1252.949882004728, 1254.9309787961568, 1268.9619311420672, 1272.335673261021, 13709.520166794315, 13802.516911908035, 13835.446582136601, 13898.444062237599, 13943.233122178175, 155109.0, 199168.00415997827, 199655.0, 200252.0, 200512.0, 55399.0, 55476.722616387466, 55588.0, 55684.0, 55906.0, 1404.908680935736, 1456.477980510348, 1458.562431270636, 1461.5615315405337, 1463.985360146385, 20148.7761958086, 20686.689699654216, 24414.877925610257, 24903.377415564755, 25627.48745025052, 45600.54399455963, 45607.31589026233, 45778.54221457743, 45797.77101114473, 45837.85405364892, 359485.0, 378224.0, 379238.10380947916, 380776.0, 381062.0, 29821.10536683903, 30398.696013039586, 30531.931382401508, 30554.388912221188, 30596.541051883793, 41110.38334425046, 41420.1715965685, 42624.5737542633, 42695.78652106844, 42786.78606606947, 34484.82757586196, 34496.827515862264, 34527.82736086303, 34786.0, 35508.28983420265, 29437.26406839846, 32745.34509309848, 34884.651153489154, 35619.10952226215, 35997.82001089978, 33220.50169247512, 34085.65914340825, 35379.82310088433, 35539.11152221215, 35637.75267865612, 21645.783542164376, 30372.392552149275, 30577.388452231276, 30636.791865014722, 30852.845735771178, 22992.310230693107, 23350.76649233486, 23566.0, 23576.410589735395, 23623.40941476477], "value": 17931.67673088187, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [412.95251046129664, 415.57403661247236, 425.1985008259431, 432.0847118547188, 437.0276135598293, 18505.35231266904, 19624.90187549062, 20915.581688366223, 20941.0, 21018.369448916557, 20705.275315363964, 20829.06269217885, 21075.367738967816, 21202.363929082112, 21383.35849924501, 6461.483081353481, 6701.061851340792, 6702.229243636995, 6718.462522998173, 6752.0, 5579.9163012554845, 6442.420182183602, 6622.867542649168, 6684.532082754209, 6706.664666766642, 6612.07430959666, 6679.499037572177, 6687.230968438643, 6687.364700353459, 6704.296048914867, 6339.619622822623, 6662.43369313604, 6676.766313179064, 6680.699368528428, 6689.866202675944, 5531.225628412026, 6187.257529096537, 6479.514036447285, 6493.253275873288, 6511.827870983221, 25258.115965941288, 25498.0, 25605.359866003313, 25743.356416089562, 25858.189926705138, 2851.401205746775, 2895.4643390972738, 2963.1703123125344, 2992.7605791536844, 3079.0916679579577, 15210.771838422432, 15821.446249381217, 16019.759703604455, 16288.661852972644, 16529.925554838897, 1461.9342129604192, 1649.488658515864, 1681.8065922418957, 1688.5272123805355, 1736.9913150434168, 120451.0, 122536.0, 124683.0, 125429.0, 127383.0, 18166.818331816776, 20183.596328073356, 20353.371730261544, 21485.0, 21751.0, 26276.0, 32186.0, 32193.51709724356, 32826.0, 32832.0, 9110.088991100969, 10618.628348007782, 10711.08955738771, 10900.400477973788, 11026.338419694845, 8836.823263534694, 8970.686025989058, 9016.459012459274, 9125.634974601075, 9206.26349892007, 8331.33349332052, 10021.899781002243, 10094.848577271347, 10151.695449136538, 10321.277510574188, 3612.6026137124895, 4222.556631553704, 4278.55075217104, 4300.376445415397, 4324.2648749712, 1049.8267785815408, 1061.5647584490323, 1069.1233188785122, 1078.5200585739271, 1118.5637601335322, 18297.634047319247, 18732.0, 20247.797522024885, 20802.895985519976, 21871.234506792505, 1107.5569772091067, 1110.2894147745449, 1110.6445937299986, 1129.2603344809163, 1137.7440075983004, 11584.594539191088, 11784.823227651592, 11793.587224447274, 11795.823062654066, 11856.170068095324, 633913.0, 649704.0, 656421.0, 718089.0, 760807.1959640166, 133066.00400993993, 140117.29941350227, 142167.28916355353, 144342.0, 157300.0, 1204.6747378207835, 1227.1961864978452, 1284.3514025417105, 1285.3380509037852, 1287.523616261989, 16873.662526749642, 18829.34097306588, 19213.711794323375, 19543.413697589094, 19598.8040119597, 43680.0, 52794.68013299698, 60403.69798150981, 67462.0, 67639.0, 69095.3090469109, 69821.0, 83053.16946830455, 85756.71364929406, 91639.0, 8655.956720216358, 9156.0, 10822.512986915764, 11120.777584448104, 11571.594994175164, 12797.552085676956, 12823.230606163661, 12833.294168820432, 13097.67255818574, 13147.408366623333, 10491.737706557396, 10823.701155861347, 11311.377874216998, 11349.205555611357, 11409.144314176305, 9268.258539316974, 10865.130789536975, 11021.173411994292, 11215.1027917768, 11234.775304493702, 11353.148513861659, 11368.317900925971, 11611.419429028683, 11665.35840528779, 11702.239354441934, 9118.270538356783, 11210.66368008961, 11412.31526108436, 11657.18399712012, 11669.824952625888, 10847.945760271148, 11006.944965275123, 11078.169137314573, 11094.778104438028, 11227.607033754106], "value": 11321.89663015168, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1373.5535950815984, 1532.2109113806391, 1536.9308381122848, 1551.8603325700685, 1576.3379380660122, 10612.363258204503, 10985.780284394328, 11173.10615150788, 11181.608643697473, 11286.604968826092, 10975.451227438636, 11145.888541114586, 11153.888461115386, 11163.330200187975, 11218.99029087382, 2394.688690470241, 2418.4316685578874, 2425.19968410425, 2428.453597940458, 2431.6352547117986, 2369.857808531485, 2389.104085967762, 2397.9040838366445, 2411.927642170729, 2412.3486658602255, 2362.433016076138, 2384.9642255366184, 2385.6779334789753, 2388.0209114263157, 2398.568257713611, 2336.8714720690355, 2347.4600841806396, 2356.7643235676383, 2357.0689577616918, 2362.0551779288335, 2024.1903238704488, 2331.63859601762, 2364.5152743687677, 2394.0902457066204, 2396.436837343223, 10971.506282217319, 11184.944075279653, 11209.383483908381, 11226.66320010401, 11233.775324493547, 5869.236999190078, 6044.335123136451, 6046.00240960241, 6064.090386442025, 6066.514678825683, 3554.253606742587, 3702.407614781622, 3731.738778285521, 3738.7943663098517, 3763.473113764075, 1184.78673838709, 1191.4697959408068, 1232.8705485923938, 1262.0156278103095, 1263.6272299671618, 10694.251402401835, 11358.886411135865, 11449.771004579861, 12319.568815091518, 13908.026438149334, 4499.167653983958, 4633.582977532038, 4784.2823576463115, 4790.4969978152485, 4807.879803004953, 11486.42567871603, 11557.76884462306, 11580.826287605692, 11583.305001699924, 11700.648980530597, 5732.398098199629, 5746.655200687972, 5750.396208398058, 5756.884862302731, 5757.65454072757, 5225.869353266199, 5269.499397557226, 5280.6303558750515, 5321.840344789663, 5379.354477462652, 3876.1666241758157, 3954.130091379892, 3972.8410863565714, 4039.0508230565792, 4048.3117869962175, 1060.6923992042375, 1061.5223149582564, 1064.0583083970587, 1074.978500429987, 1082.4641802307751, 809.9028116626042, 858.8754630578532, 901.6844104563351, 905.610587447404, 925.2782829393084, 5670.631408958405, 5832.620879642895, 6767.966160169168, 7127.287271272935, 7209.71161153548, 813.4387272781762, 945.0313428735464, 1020.8213562626511, 1021.4280003198232, 1063.8297872340388, 3826.521684789401, 4145.150244199932, 4270.935935960963, 4388.319810429389, 4398.56014398564, 13524.0, 13907.930460347634, 13924.0, 13931.512397066053, 13986.090904091201, 13356.0, 13519.594412167651, 13743.106698064794, 13852.0, 13900.304984750723, 9815.11663950248, 9951.701448956543, 10107.54516046765, 10298.639547615798, 10333.48332583383, 6519.674016299071, 6550.443212327005, 6550.868982620416, 6595.373439523238, 6654.700538475683, 11856.70358241051, 12039.578614748441, 12211.511539538318, 12325.815112773136, 12432.440540175532, 12112.939435302767, 12207.38963051826, 12263.38683065861, 12387.938060309642, 12436.440360183633, 9034.593443294936, 9189.310801689766, 9323.86014209801, 9342.766430839012, 9359.485228312507, 9581.137697607248, 9601.0, 9616.038396160608, 9683.612655493984, 9693.806123877624, 8949.32880034013, 9079.319051071065, 9173.082691730773, 9231.399959002643, 9352.67265645699, 8798.340124490816, 8845.69040083594, 8897.91102088971, 8972.955135224282, 9032.86450703227, 7735.574543400167, 7864.410169237216, 7897.486663367093, 7911.723089692064, 7912.32745216663, 4954.355933728736, 5745.0, 5778.566607504538, 5916.083007133729, 6000.849978750566, 4679.812807487799, 5746.942530574808, 5874.911876321944, 5966.134910438049, 6140.20177376956], "value": 5098.0045166556865, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.88995521433134, 360.7068658857994, 367.5185506985849, 377.55448570686593, 380.7867594147276, 4381.649468042557, 4710.74090924999, 4980.477049909757, 5341.1988201769655, 5379.865503362408, 4349.913001739963, 5017.347744793181, 5037.093323201822, 5210.55710264627, 5267.26258323835, 4164.937525937114, 4274.893127671802, 4306.12683482686, 4309.6336811371075, 4358.585934336233, 3707.3697471429787, 3864.86472973446, 3951.802409879509, 4104.6716262699065, 4360.411344468504, 4046.5953404659595, 4319.956800431987, 4343.153085148398, 4381.496127945279, 4385.736855788647, 3583.8208089595414, 3984.9402258965993, 4082.5183585100176, 4247.532771395144, 4350.564943505656, 3568.7145028397927, 3965.0087478130467, 3982.900427489307, 3996.660283875845, 4006.659433948089, 4987.6758010729545, 5072.492750724935, 5118.309028281172, 5129.974350128263, 5160.793568257265, 4277.97861010696, 4690.366800481926, 5007.198848184273, 5085.974570127126, 5107.0, 5194.870128246786, 5452.04589196889, 5549.667019978814, 5587.664740115565, 5649.4633009864, 3862.478565393664, 3926.9986153530667, 4477.306017567283, 4503.211937910853, 4520.5253448387775, 5666.603337766358, 5886.528367908023, 5913.763449462016, 5935.91096133554, 6043.91209582275, 4053.8986525337104, 4129.6489798367475, 4393.956060439355, 4456.501646207711, 4574.794134263966, 4480.439945006874, 4646.674732768742, 4669.696469729457, 4672.57946784791, 4696.671233013724, 4155.444401692937, 4878.3406461907225, 4883.243097319921, 4981.32752078472, 5026.547610715053, 4939.851804445872, 5541.032933308698, 5573.247611572386, 5576.330840299109, 5577.553795696334, 1381.5233744358181, 1507.8588404465686, 1560.680060587577, 1595.755310857533, 1595.8882878198647, 979.0894468144694, 1016.8661941934689, 1108.1190453589415, 1197.706561892342, 1198.4427241332821, 4623.976880115578, 5034.6727462715535, 5034.974825125924, 5195.922061169085, 5251.36983561975, 5311.362636483569, 5516.475934786269, 5795.391483894215, 5851.61964472308, 5868.530517558585, 4066.9222655996186, 4504.234280172379, 4738.336632871401, 4847.854564363075, 5262.368515778055, 2835.1854812919746, 2957.4085182963495, 3043.7260646541918, 3076.6000419945262, 3079.629564843623, 5702.914456283159, 5938.972347615927, 5996.67018313997, 6015.849603759941, 6163.84590385244, 5357.973210133924, 5673.574481913873, 5677.0, 5843.737031833492, 5996.141196229183, 5295.6822590643915, 5306.230596563477, 5365.222042803772, 5821.476067153976, 5949.553783466171, 5216.452272511332, 5361.236670579221, 5847.544031506863, 5900.793472228452, 5912.73392697321, 5306.399864066657, 5438.314122621841, 5575.0, 5775.768969241183, 5838.649681019152, 5041.899162016813, 5313.707746073848, 5957.344692083954, 6022.759089636365, 6054.39456054391, 3981.1639555693628, 4073.7555746655294, 4312.310030395121, 4553.817847286204, 4672.696274742131, 4921.803127874845, 5022.639359501029, 5142.537171654569, 5796.478316951495, 5917.792877249448, 4887.43794463627, 5386.0, 5503.3395992481155, 5521.4478552144465, 5552.0, 5456.772226249062, 5647.0, 5665.858353541194, 5676.105186354906, 5764.59647824665, 4820.228763397839, 5068.046923399754, 5222.947770522398, 5339.46605339463, 5432.918506222489, 5153.7165455898785, 5446.428125046813, 5604.935062338142, 5666.518345940642, 5690.0611399120335, 4606.493285738499, 4751.524847515221, 4949.851504454872, 5111.0, 5548.55611551083], "value": 4251.321202204687, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [710.733474946895, 720.6036679826097, 749.8537785131895, 761.5659074327635, 825.4799476329913, 14639.560813175609, 15455.768163477556, 15649.0, 15666.921665391686, 15732.921335393321, 14650.853491465083, 15284.923575382136, 15307.234638268097, 15327.233638318095, 15351.92324038381, 916.0381599320704, 943.367943477868, 943.7687766497218, 945.3146468810093, 946.9952650236739, 924.3575714878162, 947.8436058050413, 949.9952500237524, 951.2295041016764, 953.3993584042079, 1006.1196453103535, 1019.1948360794963, 1020.9336393134422, 1021.4637315409433, 1022.8465730140464, 991.8660980767576, 1010.3584224017728, 1011.726833754882, 1013.989860101397, 1014.2747935226348, 624.3912185619031, 749.0225256040865, 751.4702134994816, 751.579115695207, 753.8153152477623, 15539.300731466998, 16026.839731602651, 16078.919605402016, 16322.347106115742, 16604.50186494407, 14032.228227447486, 14151.221682807442, 14234.501792437319, 14365.281735913162, 14384.35270412834, 11649.70875728105, 11805.822912656316, 11812.11409144309, 11816.231944923553, 11894.345810980392, 3312.3540909522653, 3646.5624125105155, 3684.244729830405, 3707.776433776847, 3708.7774733515807, 82001.58999205026, 96626.03373966241, 100502.0, 100845.99154008439, 101370.49314753452, 10306.433146177033, 10656.307340022873, 10745.731356715989, 10846.18653600983, 10881.945590271998, 18720.719189212174, 22471.775282246967, 22676.433089172573, 22847.543049139258, 22880.542389152124, 7701.576413297211, 7726.9613651932505, 7728.0, 7873.1733168016535, 7978.3218426434405, 4273.658107351404, 4311.396404503372, 4389.209942210433, 4406.845760398371, 4429.0, 3522.2427178156818, 3564.1446052947626, 3602.1715005548344, 3623.4927110204594, 3633.781973081571, 649.0880313160018, 651.1665068712056, 653.2748648999607, 657.947364210862, 659.152988409891, 611.8806832667676, 655.6557807151283, 663.3912761553214, 671.8891382921763, 694.3889377347901, 9896.356736812084, 10165.94917025425, 10226.181905447545, 10331.535080921376, 10357.482125893675, 563.2452513631671, 615.9137720719103, 616.824205101544, 642.7429028388589, 701.0525690408032, 4657.3246879202325, 5005.1241032819835, 5134.768935397916, 5135.306733590917, 5137.8201762938115, 100183.0, 102222.0, 102314.48842755739, 103071.96928030624, 105673.94326056795, 51322.74338628283, 65800.34199658038, 70764.0, 79391.0, 80792.0, 71263.64368178126, 72573.0, 74337.25662743411, 75156.62421687857, 75987.24012759802, 10878.564857405616, 11103.5558577656, 11129.610463633733, 11243.381614011309, 11374.886251137383, 37019.0, 39449.60550394459, 50056.74971625264, 50572.0, 52217.47782522126, 64363.034554480786, 64664.0, 65896.67051664711, 67391.66304168447, 67506.31234218988, 10264.692059238234, 12641.93679031599, 12781.16922400041, 12899.921942197347, 13010.21938683682, 14370.712585748435, 14389.496367627084, 14400.711985760436, 14560.781588275973, 15318.157501337533, 11168.944155279172, 13036.674083147996, 13505.729885402041, 13837.723245534831, 13888.166709997433, 13381.732365352444, 13640.795388069386, 13805.930970345084, 13841.792373114613, 13869.09850859691, 12241.571544995883, 12815.359232038547, 13164.934175329063, 13595.456181753014, 13844.653883652989, 10899.673009809718, 10908.61819836302, 11087.0, 11090.944545277545, 11530.365829879438, 10476.79046419052, 10677.199210059121, 11041.516822504826, 11432.771344572895, 11922.880771192524], "value": 7552.887686477577, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1568.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 120.0, 122.0, 119.0, 120.0, 119.0, 118.0, 125.0, 114.0, 119.0], "value": 118.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 113.0, 108.0, 182.0, 146.0, 142.0, 113.0, 114.0, 134.0, 111.0], "value": 130.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [207.0, 198.0, 197.0, 199.0, 198.0, 199.0, 202.0, 187.0, 285.0, 250.0], "value": 212.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 60.0, 76.0, 87.0, 62.0, 55.0, 69.0, 64.0, 74.0, 63.0], "value": 69.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 69.0, 85.0, 74.0, 72.0, 69.0, 85.0, 69.0, 69.0, 84.0], "value": 76.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 135.0, 103.0, 88.0, 117.0, 87.0, 134.0, 135.0, 89.0, 88.0], "value": 106.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 144.0, 97.0, 110.0, 152.0, 130.0, 98.0, 97.0, 97.0], "value": 111.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 142.0, 142.0, 105.0, 90.0, 92.0, 127.0, 142.0, 99.0, 92.0], "value": 112.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 67.0, 70.0, 68.0, 69.0, 67.0, 69.0, 69.0, 68.0], "value": 68.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 63.0, 65.0, 59.0, 57.0, 59.0, 59.0, 59.0, 58.0, 59.0], "value": 59.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 88.0, 85.0, 86.0, 86.0, 92.0, 87.0, 87.0, 94.0], "value": 87.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 153.0, 157.0, 149.0, 149.0, 140.0, 141.0, 153.0, 202.0, 177.0], "value": 157.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 169.0, 200.0, 151.0, 158.0, 227.0, 228.0, 213.0, 222.0, 181.0], "value": 191.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 66.0, 65.0, 66.0, 67.0, 67.0, 66.0, 74.0, 64.0], "value": 66.8, "unit": "score"}]}]} 02:04:50 INFO - Return code: 0 02:04:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:04:50 ERROR - # TBPL SUCCESS # 02:04:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:04:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:04:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:04:50 INFO - 2017-03-13 02:04:50.912 screenresolution[1670:12056] starting screenresolution argv=screenresolution get 02:04:50 INFO - 2017-03-13 02:04:50.915 screenresolution[1670:12056] Display 0: 1600x1200x32@60 02:04:50 INFO - 2017-03-13 02:04:50.921 screenresolution[1671:12059] starting screenresolution argv=screenresolution list 02:04:50 INFO - Available Modes on Display 0 02:04:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:04:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:04:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:04:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:04:51 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:04:51 INFO - Intel Iris: 02:04:51 INFO - Chipset Model: Intel Iris 02:04:51 INFO - Type: GPU 02:04:51 INFO - Bus: Built-In 02:04:51 INFO - VRAM (Dynamic, Max): 1536 MB 02:04:51 INFO - Vendor: Intel (0x8086) 02:04:51 INFO - Device ID: 0x0a2e 02:04:51 INFO - Revision ID: 0x0009 02:04:51 INFO - Displays: 02:04:51 INFO - Display: 02:04:51 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:04:51 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:04:51 INFO - Display Serial Number: 1600x1200 60 02:04:51 INFO - Main Display: Yes 02:04:51 INFO - Mirror: Off 02:04:51 INFO - Online: Yes 02:04:51 INFO - Rotation: Supported 02:04:51 INFO - Return code: 0 02:04:51 INFO - Running post-action listener: _resource_record_post_action 02:04:51 INFO - [mozharness: 2017-03-13 09:04:51.155262Z] Finished run-tests step (success) 02:04:51 INFO - Running post-run listener: _resource_record_post_run 02:04:51 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 33886208; Write bytes: 515676160; Read time: 201; Write time: 1687 02:04:51 INFO - TinderboxPrint: CPU usage
54.4% 02:04:51 INFO - TinderboxPrint: I/O read bytes / time
33,886,208 / 201 02:04:51 INFO - TinderboxPrint: I/O write bytes / time
515,676,160 / 1,687 02:04:51 INFO - TinderboxPrint: CPU idle
2,190.2 (45.6%) 02:04:51 INFO - TinderboxPrint: CPU system
960.9 (20.0%) 02:04:51 INFO - TinderboxPrint: CPU user
1,654.8 (34.4%) 02:04:51 INFO - TinderboxPrint: Swap in / out
239,177,728 / 0 02:04:51 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 206178816; Write bytes: 202966528; Read time: 15678; Write time: 439 02:04:51 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 31817728; Write bytes: 301675008; Read time: 182; Write time: 1216 02:04:51 INFO - Running post-run listener: _upload_blobber_files 02:04:51 INFO - Blob upload gear active. 02:04:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:04:51 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 02:04:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:04:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:04:52 INFO - (blobuploader) - INFO - Open directory for files ... 02:04:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:04:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:04:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:04:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:04:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:04:53 INFO - (blobuploader) - INFO - Done attempting. 02:04:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:04:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:04:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:04:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:04:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:04:54 INFO - (blobuploader) - INFO - Done attempting. 02:04:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 02:04:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:04:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:04:55 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 02:04:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:04:55 INFO - (blobuploader) - INFO - Done attempting. 02:04:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:04:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:04:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:04:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:04:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:04:57 INFO - (blobuploader) - INFO - Done attempting. 02:04:57 INFO - (blobuploader) - INFO - Iteration through files over. 02:04:57 INFO - Return code: 0 02:04:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:04:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:04:57 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b5df38978e4f724e5b338925108bedb028dc53a684e185408dfd7649483c8336b73e72765bab4865591158f0fe67906c3126a8fa3e473f847babc8fbcb266163", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5a6d0095cc1b91c38449b241ad0a8957ed11750d09a38ab2dff4ca2e6cb9c262a6657b5a30f89a847c3b35b5ca8c08c280b866b6b4cf36b80c62995049161951", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b3658ee0580e04007637e5e7094d88a334fce0f47f339a621075590df8c4ed633fd3ab5cdec719b64bcc3df82f26d5b56af501eeb4ee84c0246d8222022be1dd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3e1d91e157ff4fb97fe115a761cc406416f8e612d20f212f426358236aeb365b7b96329deb50eafed79d96efe0ef162e72f192ed015ba86f56d4b578507d2c1d"} 02:04:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:04:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:04:57 INFO - Contents: 02:04:57 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b5df38978e4f724e5b338925108bedb028dc53a684e185408dfd7649483c8336b73e72765bab4865591158f0fe67906c3126a8fa3e473f847babc8fbcb266163", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5a6d0095cc1b91c38449b241ad0a8957ed11750d09a38ab2dff4ca2e6cb9c262a6657b5a30f89a847c3b35b5ca8c08c280b866b6b4cf36b80c62995049161951", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b3658ee0580e04007637e5e7094d88a334fce0f47f339a621075590df8c4ed633fd3ab5cdec719b64bcc3df82f26d5b56af501eeb4ee84c0246d8222022be1dd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3e1d91e157ff4fb97fe115a761cc406416f8e612d20f212f426358236aeb365b7b96329deb50eafed79d96efe0ef162e72f192ed015ba86f56d4b578507d2c1d"} 02:04:57 INFO - Running post-run listener: copy_logs_to_upload_dir 02:04:57 INFO - Copying logs to upload dir... 02:04:57 INFO - mkdir: /builds/slave/test/build/upload/logs 02:04:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1283.672371 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2017-03-13 02:04:57.426462) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-13 02:04:57.429643) ========= 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.P1ipL4iSil/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.ChBpYS05HA/Listeners TMPDIR=/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b5df38978e4f724e5b338925108bedb028dc53a684e185408dfd7649483c8336b73e72765bab4865591158f0fe67906c3126a8fa3e473f847babc8fbcb266163", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5a6d0095cc1b91c38449b241ad0a8957ed11750d09a38ab2dff4ca2e6cb9c262a6657b5a30f89a847c3b35b5ca8c08c280b866b6b4cf36b80c62995049161951", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b3658ee0580e04007637e5e7094d88a334fce0f47f339a621075590df8c4ed633fd3ab5cdec719b64bcc3df82f26d5b56af501eeb4ee84c0246d8222022be1dd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3e1d91e157ff4fb97fe115a761cc406416f8e612d20f212f426358236aeb365b7b96329deb50eafed79d96efe0ef162e72f192ed015ba86f56d4b578507d2c1d"} build_url:https://queue.taskcluster.net/v1/task/I7YFBn11QtG5YAwMzKQTUA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011075 build_url: 'https://queue.taskcluster.net/v1/task/I7YFBn11QtG5YAwMzKQTUA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b5df38978e4f724e5b338925108bedb028dc53a684e185408dfd7649483c8336b73e72765bab4865591158f0fe67906c3126a8fa3e473f847babc8fbcb266163", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5a6d0095cc1b91c38449b241ad0a8957ed11750d09a38ab2dff4ca2e6cb9c262a6657b5a30f89a847c3b35b5ca8c08c280b866b6b4cf36b80c62995049161951", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b3658ee0580e04007637e5e7094d88a334fce0f47f339a621075590df8c4ed633fd3ab5cdec719b64bcc3df82f26d5b56af501eeb4ee84c0246d8222022be1dd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3e1d91e157ff4fb97fe115a761cc406416f8e612d20f212f426358236aeb365b7b96329deb50eafed79d96efe0ef162e72f192ed015ba86f56d4b578507d2c1d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-13 02:04:57.463613) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-13 02:04:57.463931) ========= 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.P1ipL4iSil/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.ChBpYS05HA/Listeners TMPDIR=/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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.005128 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-13 02:04:57.512128) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-13 02:04:57.512445) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-13 02:04:57.512769) ========= ========= Total master_lag: 0.22 =========