builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0278 starttime: 1493898308.6 results: success (0) buildid: 20170504030320 builduid: f8ddb320b6584f09823832bba887e606 revision: 33b92d9c40562dab3d7b602368c75619f1d793f7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-04 04:45:08.596201) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-04 04:45:08.597052) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-04 04:45:08.597576) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-04 04:45:08.626926) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 04:45:08.627446) ========= 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.OQoKw3BQDd/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.lHUImak13K/Listeners TMPDIR=/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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-05-04 04:45:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 142M=0s 2017-05-04 04:45:08 (142 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.131457 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 04:45:08.784631) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 04:45:08.785009) ========= 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.OQoKw3BQDd/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.lHUImak13K/Listeners TMPDIR=/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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.026467 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 04:45:08.835381) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 04:45:08.835956) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 33b92d9c40562dab3d7b602368c75619f1d793f7 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 33b92d9c40562dab3d7b602368c75619f1d793f7 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.OQoKw3BQDd/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.lHUImak13K/Listeners TMPDIR=/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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-05-04 04:45:08,945 truncating revision to first 12 chars 2017-05-04 04:45:08,945 Setting DEBUG logging. 2017-05-04 04:45:08,945 attempt 1/10 2017-05-04 04:45:08,945 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/33b92d9c4056?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-04 04:45:09,582 unpacking tar archive at: mozilla-central-33b92d9c4056/testing/mozharness/ program finished with exit code 0 elapsedTime=0.923818 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 04:45:09.784660) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-04 04:45:09.785032) ========= script_repo_revision: 33b92d9c40562dab3d7b602368c75619f1d793f7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-04 04:45:09.785485) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-04 04:45:09.785813) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-04 04:45:09.806796) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2017-05-04 04:45:09.807137) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.OQoKw3BQDd/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.lHUImak13K/Listeners TMPDIR=/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 04:45:10 INFO - MultiFileLogger online at 20170504 04:45:10 in /builds/slave/test 04:45:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:45:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:45:10 INFO - {'append_to_log': False, 04:45:10 INFO - 'base_work_dir': '/builds/slave/test', 04:45:10 INFO - 'blob_upload_branch': 'Firefox', 04:45:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:45:10 INFO - 'branch': 'Firefox', 04:45:10 INFO - 'buildbot_json_path': 'buildprops.json', 04:45:10 INFO - 'config_files': ('talos/mac_config.py',), 04:45:10 INFO - 'default_actions': ('clobber', 04:45:10 INFO - 'read-buildbot-config', 04:45:10 INFO - 'download-and-extract', 04:45:10 INFO - 'populate-webroot', 04:45:10 INFO - 'create-virtualenv', 04:45:10 INFO - 'install', 04:45:10 INFO - 'run-tests'), 04:45:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:45:10 INFO - 'download_minidump_stackwalk': True, 04:45:10 INFO - 'download_symbols': 'ondemand', 04:45:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:45:10 INFO - 'tooltool.py': '/tools/tooltool.py', 04:45:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:45:10 INFO - '/tools/misc-python/virtualenv.py')}, 04:45:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:45:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:45:10 INFO - 'gecko_profile': False, 04:45:10 INFO - 'gecko_profile_interval': 0, 04:45:10 INFO - 'installer_path': 'installer.exe', 04:45:10 INFO - 'log_level': 'info', 04:45:10 INFO - 'log_name': 'talos', 04:45:10 INFO - 'log_to_console': True, 04:45:10 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:45:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:45:10 INFO - 'opt_config_files': (), 04:45:10 INFO - 'pip_index': False, 04:45:10 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:45:10 INFO - 'cmd': ('bash', 04:45:10 INFO - '-c', 04:45:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:45:10 INFO - 'enabled': True, 04:45:10 INFO - 'halt_on_failure': False, 04:45:10 INFO - 'name': 'check_screen_resolution'},), 04:45:10 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:45:10 INFO - 'cmd': ('bash', 04:45:10 INFO - '-c', 04:45:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:45:10 INFO - 'enabled': True, 04:45:10 INFO - 'halt_on_failure': False, 04:45:10 INFO - 'name': 'check_screen_resolution'},), 04:45:10 INFO - 'run_cmd_checks_enabled': True, 04:45:10 INFO - 'suite': 'dromaeojs-e10s', 04:45:10 INFO - 'system_bits': '32', 04:45:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:45:10 INFO - 'title': 't-yosemite-r7-0278', 04:45:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:45:10 INFO - 'use_talos_json': True, 04:45:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:45:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:45:10 INFO - 'work_dir': 'build'} 04:45:10 INFO - [mozharness: 2017-05-04 11:45:10.023956Z] Running clobber step. 04:45:10 INFO - Running pre-action listener: _resource_record_pre_action 04:45:10 INFO - Running main action method: clobber 04:45:10 INFO - rmtree: /builds/slave/test/build 04:45:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:45:12 INFO - Running post-action listener: _resource_record_post_action 04:45:12 INFO - [mozharness: 2017-05-04 11:45:12.405021Z] Finished clobber step (success) 04:45:12 INFO - [mozharness: 2017-05-04 11:45:12.405170Z] Running read-buildbot-config step. 04:45:12 INFO - Running pre-action listener: _resource_record_pre_action 04:45:12 INFO - Running main action method: read_buildbot_config 04:45:12 INFO - Using buildbot properties: 04:45:12 INFO - { 04:45:12 INFO - "project": "", 04:45:12 INFO - "product": "firefox", 04:45:12 INFO - "script_repo_revision": "production", 04:45:12 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 04:45:12 INFO - "repository": "", 04:45:12 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 04:45:12 INFO - "buildid": "20170504030320", 04:45:12 INFO - "stage_platform": "macosx64", 04:45:12 INFO - "basedir": "/builds/slave/test", 04:45:12 INFO - "nightly_build": "True", 04:45:12 INFO - "buildnumber": 56, 04:45:12 INFO - "slavename": "t-yosemite-r7-0278", 04:45:12 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 04:45:12 INFO - "platform": "yosemite_r7", 04:45:12 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:45:12 INFO - "branch": "mozilla-central", 04:45:12 INFO - "repo_path": "mozilla-central", 04:45:12 INFO - "revision": "33b92d9c40562dab3d7b602368c75619f1d793f7", 04:45:12 INFO - "pgo_build": "False", 04:45:12 INFO - "builduid": "f8ddb320b6584f09823832bba887e606", 04:45:12 INFO - "slavebuilddir": "test" 04:45:12 INFO - } 04:45:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/a3xjx-0rSQO3SRK0QXEI0Q/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 04:45:12 INFO - Running post-action listener: _resource_record_post_action 04:45:12 INFO - [mozharness: 2017-05-04 11:45:12.408547Z] Finished read-buildbot-config step (success) 04:45:12 INFO - [mozharness: 2017-05-04 11:45:12.408662Z] Running download-and-extract step. 04:45:12 INFO - Running pre-action listener: _resource_record_pre_action 04:45:12 INFO - Running main action method: download_and_extract 04:45:12 INFO - mkdir: /builds/slave/test/build/tests 04:45:12 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')]} 04:45:12 INFO - trying https://queue.taskcluster.net/v1/task/a3xjx-0rSQO3SRK0QXEI0Q/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 04:45:12 INFO - Downloading https://queue.taskcluster.net/v1/task/a3xjx-0rSQO3SRK0QXEI0Q/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 04:45:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/a3xjx-0rSQO3SRK0QXEI0Q/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 04:45:13 INFO - Downloaded 1325 bytes. 04:45:13 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 04:45:13 INFO - Using the following test package requirements: 04:45:13 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:45:13 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 04:45:13 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:45:13 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:45:13 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 04:45:13 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:45:13 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 04:45:13 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:45:13 INFO - u'jsshell-mac.zip'], 04:45:13 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:45:13 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 04:45:13 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:45:13 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:45:13 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 04:45:13 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:45:13 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 04:45:13 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:45:13 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 04:45:13 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:45:13 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 04:45:13 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:45:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/a3xjx-0rSQO3SRK0QXEI0Q/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:45:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a3xjx-0rSQO3SRK0QXEI0Q/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:45:13 INFO - Fetch https://queue.taskcluster.net/v1/task/a3xjx-0rSQO3SRK0QXEI0Q/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:45:15 INFO - Content-Length response header: 52700863 04:45:15 INFO - Bytes received: 52700863 04:45:31 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:45:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/a3xjx-0rSQO3SRK0QXEI0Q/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:45:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a3xjx-0rSQO3SRK0QXEI0Q/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:45:31 INFO - Fetch https://queue.taskcluster.net/v1/task/a3xjx-0rSQO3SRK0QXEI0Q/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:45:33 INFO - Content-Length response header: 52700863 04:45:33 INFO - Bytes received: 52700863 04:45:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/a3xjx-0rSQO3SRK0QXEI0Q/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 04:45:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a3xjx-0rSQO3SRK0QXEI0Q/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:45:48 INFO - Fetch https://queue.taskcluster.net/v1/task/a3xjx-0rSQO3SRK0QXEI0Q/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 04:45:49 INFO - Content-Length response header: 14408809 04:45:49 INFO - Bytes received: 14408809 04:45:49 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')]} 04:45:49 INFO - trying https://queue.taskcluster.net/v1/task/a3xjx-0rSQO3SRK0QXEI0Q/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:45:49 INFO - Downloading https://queue.taskcluster.net/v1/task/a3xjx-0rSQO3SRK0QXEI0Q/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 04:45:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/a3xjx-0rSQO3SRK0QXEI0Q/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 04:45:52 INFO - Downloaded 70961348 bytes. 04:45:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/a3xjx-0rSQO3SRK0QXEI0Q/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:45:52 INFO - mkdir: /builds/slave/test/properties 04:45:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:45:52 INFO - Writing to file /builds/slave/test/properties/build_url 04:45:52 INFO - Contents: 04:45:52 INFO - build_url:https://queue.taskcluster.net/v1/task/a3xjx-0rSQO3SRK0QXEI0Q/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:45:52 WARNING - Cannot open symbols url https://queue.taskcluster.net/v1/task/a3xjx-0rSQO3SRK0QXEI0Q/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip (installer url: https://queue.taskcluster.net/v1/task/a3xjx-0rSQO3SRK0QXEI0Q/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg): HTTP Error 500: Internal Server Error 04:45:52 WARNING - No symbols_url found. Let minidump_stackwalk query for symbols. 04:45:52 INFO - Running post-action listener: _resource_record_post_action 04:45:52 INFO - Running post-action listener: set_extra_try_arguments 04:45:52 INFO - [mozharness: 2017-05-04 11:45:52.753475Z] Finished download-and-extract step (success) 04:45:52 INFO - [mozharness: 2017-05-04 11:45:52.753628Z] Running populate-webroot step. 04:45:52 INFO - Running pre-action listener: _resource_record_pre_action 04:45:52 INFO - Running main action method: populate_webroot 04:45:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:45:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:45:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:45:52 INFO - '--tppagecycles', 04:45:52 INFO - '7'], 04:45:52 INFO - 'tests': ['tsvgm']}}, 04:45:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:45:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:45:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:45:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:45:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:45:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:45:52 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:45:52 INFO - 'talos_options': ['--disable-e10s'], 04:45:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:45:52 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:45:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:45:52 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:45:52 INFO - 'talos_options': ['--disable-e10s'], 04:45:52 INFO - 'tests': ['damp', 'tps']}, 04:45:52 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:45:52 INFO - 'tests': ['damp', 'tps']}, 04:45:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:45:52 INFO - 'tests': ['dromaeo_dom']}, 04:45:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:45:52 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:45:52 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 04:45:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 04:45:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:45:52 INFO - 'tests': ['a11yr', 04:45:52 INFO - 'ts_paint', 04:45:52 INFO - 'tpaint', 04:45:52 INFO - 'sessionrestore', 04:45:52 INFO - 'sessionrestore_no_auto_restore', 04:45:52 INFO - 'tabpaint']}, 04:45:52 INFO - 'other-e10s': {'tests': ['a11yr', 04:45:52 INFO - 'ts_paint', 04:45:52 INFO - 'tpaint', 04:45:52 INFO - 'sessionrestore', 04:45:52 INFO - 'sessionrestore_no_auto_restore', 04:45:52 INFO - 'tabpaint']}, 04:45:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:45:52 INFO - 'ts_paint', 04:45:52 INFO - 'tpaint', 04:45:52 INFO - 'sessionrestore', 04:45:52 INFO - 'sessionrestore_no_auto_restore', 04:45:52 INFO - 'tabpaint']}, 04:45:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:45:52 INFO - 'ts_paint', 04:45:52 INFO - 'tpaint', 04:45:52 INFO - 'sessionrestore', 04:45:52 INFO - 'sessionrestore_no_auto_restore', 04:45:52 INFO - 'tabpaint']}, 04:45:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:45:52 INFO - 'tests': ['a11yr', 04:45:52 INFO - 'ts_paint', 04:45:52 INFO - 'tpaint', 04:45:52 INFO - 'sessionrestore', 04:45:52 INFO - 'sessionrestore_no_auto_restore', 04:45:52 INFO - 'tabpaint']}, 04:45:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:45:52 INFO - 'tests': ['a11yr', 04:45:52 INFO - 'ts_paint', 04:45:52 INFO - 'tpaint', 04:45:52 INFO - 'sessionrestore', 04:45:52 INFO - 'sessionrestore_no_auto_restore', 04:45:52 INFO - 'tabpaint']}, 04:45:52 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 04:45:52 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 04:45:52 INFO - 'bloom_basic_ref']}, 04:45:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:45:52 INFO - 'tests': ['tsvgx', 04:45:52 INFO - 'tsvgr_opacity', 04:45:52 INFO - 'tart', 04:45:52 INFO - 'tscrollx', 04:45:52 INFO - 'cart', 04:45:52 INFO - 'tsvg_static']}, 04:45:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:45:52 INFO - 'tsvgr_opacity', 04:45:52 INFO - 'tart', 04:45:52 INFO - 'tscrollx', 04:45:52 INFO - 'cart', 04:45:52 INFO - 'tsvg_static']}, 04:45:52 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:45:52 INFO - 'talos_options': ['--disable-e10s'], 04:45:52 INFO - 'tests': ['tp5o']}, 04:45:52 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:45:52 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:45:52 INFO - 'talos_options': ['--disable-e10s', 04:45:52 INFO - '--xperf_path', 04:45:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:45:52 INFO - 'tests': ['tp5n']}, 04:45:52 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:45:52 INFO - 'talos_options': ['--xperf_path', 04:45:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:45:52 INFO - 'tests': ['tp5n']}}, 04:45:52 INFO - 'talos.zip': {'path': '', 04:45:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:45:52 INFO - Running post-action listener: _resource_record_post_action 04:45:52 INFO - [mozharness: 2017-05-04 11:45:52.772846Z] Finished populate-webroot step (success) 04:45:52 INFO - [mozharness: 2017-05-04 11:45:52.772955Z] Running create-virtualenv step. 04:45:52 INFO - Running pre-action listener: _resource_record_pre_action 04:45:52 INFO - Running main action method: create_virtualenv 04:45:52 INFO - Creating virtualenv /builds/slave/test/build/venv 04:45:52 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 04:45:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:45:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:45:52 INFO - Using real prefix '/tools/python27' 04:45:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:45:53 INFO - Installing distribute.............................................................................................................................................................................................done. 04:45:56 INFO - Installing pip.................done. 04:45:56 INFO - Return code: 0 04:45:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:45:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:45:56 INFO - Reading from file tmpfile_stdout 04:45:56 INFO - Output received: 04:45:56 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) 04:45:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:45:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:45:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:45:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c58cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c58f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0504cdda0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c36ad30>, '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 0x10c290db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c35fbe8>, '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.OQoKw3BQDd/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.lHUImak13K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 04:45:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:45:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:45:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OQoKw3BQDd/Render', 04:45:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:45:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:45:56 INFO - 'HOME': '/Users/cltbld', 04:45:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:45:56 INFO - 'LOGNAME': 'cltbld', 04:45:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:56 INFO - 'MOZ_NO_REMOTE': '1', 04:45:56 INFO - 'NO_EM_RESTART': '1', 04:45:56 INFO - 'PAGER': '/bin/cat', 04:45:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:45:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:56 INFO - 'PWD': '/builds/slave/test', 04:45:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:45:56 INFO - 'SHELL': '/bin/bash', 04:45:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lHUImak13K/Listeners', 04:45:56 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 04:45:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:45:56 INFO - 'USER': 'cltbld', 04:45:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:45:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:45:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:56 INFO - 'XPC_FLAGS': '0x0', 04:45:56 INFO - 'XPC_SERVICE_NAME': '0', 04:45:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:45:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:57 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 04:45:57 INFO - Cleaning up... 04:45:57 INFO - Return code: 0 04:45:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:45:57 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')]} 04:45:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:57 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')]} 04:45:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:57 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 0x10c58cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c58f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0504cdda0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c36ad30>, '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 0x10c290db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c35fbe8>, '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.OQoKw3BQDd/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.lHUImak13K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 04:45:57 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 04:45:57 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 04:45:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OQoKw3BQDd/Render', 04:45:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:45:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:45:57 INFO - 'HOME': '/Users/cltbld', 04:45:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:45:57 INFO - 'LOGNAME': 'cltbld', 04:45:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:57 INFO - 'MOZ_NO_REMOTE': '1', 04:45:57 INFO - 'NO_EM_RESTART': '1', 04:45:57 INFO - 'PAGER': '/bin/cat', 04:45:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:45:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:57 INFO - 'PWD': '/builds/slave/test', 04:45:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:45:57 INFO - 'SHELL': '/bin/bash', 04:45:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lHUImak13K/Listeners', 04:45:57 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 04:45:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:45:57 INFO - 'USER': 'cltbld', 04:45:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:45:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:45:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:57 INFO - 'XPC_FLAGS': '0x0', 04:45:57 INFO - 'XPC_SERVICE_NAME': '0', 04:45:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:45:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:57 INFO - Downloading/unpacking psutil>=3.1.1 04:45:57 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 04:45:57 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 04:45:57 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 04:45:57 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 04:45:57 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 04:45:57 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 04:45:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:45:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:45:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:45:59 INFO - Installing collected packages: psutil 04:45:59 INFO - Running setup.py install for psutil 04:45:59 INFO - building 'psutil._psutil_osx' extension 04:45:59 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 04:46:00 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 04:46:00 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 04:46:00 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 04:46:00 INFO - building 'psutil._psutil_posix' extension 04:46:00 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 04:46:00 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:46:00 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:46:00 INFO - ^ 04:46:00 INFO - 1 warning generated. 04:46:00 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 04:46:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:46:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:46:00 INFO - Successfully installed psutil 04:46:00 INFO - Cleaning up... 04:46:00 INFO - Return code: 0 04:46:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:46:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:46:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:46:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c58cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c58f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0504cdda0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c36ad30>, '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 0x10c290db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c35fbe8>, '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.OQoKw3BQDd/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.lHUImak13K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 04:46:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:46:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:46:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OQoKw3BQDd/Render', 04:46:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:46:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:46:00 INFO - 'HOME': '/Users/cltbld', 04:46:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:46:00 INFO - 'LOGNAME': 'cltbld', 04:46:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:00 INFO - 'MOZ_NO_REMOTE': '1', 04:46:00 INFO - 'NO_EM_RESTART': '1', 04:46:00 INFO - 'PAGER': '/bin/cat', 04:46:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:46:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:00 INFO - 'PWD': '/builds/slave/test', 04:46:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:46:00 INFO - 'SHELL': '/bin/bash', 04:46:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lHUImak13K/Listeners', 04:46:00 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 04:46:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:46:00 INFO - 'USER': 'cltbld', 04:46:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:46:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:46:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:00 INFO - 'XPC_FLAGS': '0x0', 04:46:00 INFO - 'XPC_SERVICE_NAME': '0', 04:46:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:46:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:46:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:46:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:46:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:46:02 INFO - Installing collected packages: mozsystemmonitor 04:46:02 INFO - Running setup.py install for mozsystemmonitor 04:46:02 INFO - Successfully installed mozsystemmonitor 04:46:02 INFO - Cleaning up... 04:46:02 INFO - Return code: 0 04:46:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:46:02 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')]} 04:46:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:02 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')]} 04:46:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:02 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 0x10c58cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c58f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0504cdda0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c36ad30>, '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 0x10c290db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c35fbe8>, '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.OQoKw3BQDd/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.lHUImak13K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 04:46:02 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 04:46:02 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 04:46:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OQoKw3BQDd/Render', 04:46:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:46:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:46:02 INFO - 'HOME': '/Users/cltbld', 04:46:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:46:02 INFO - 'LOGNAME': 'cltbld', 04:46:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:02 INFO - 'MOZ_NO_REMOTE': '1', 04:46:02 INFO - 'NO_EM_RESTART': '1', 04:46:02 INFO - 'PAGER': '/bin/cat', 04:46:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:46:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:02 INFO - 'PWD': '/builds/slave/test', 04:46:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:46:02 INFO - 'SHELL': '/bin/bash', 04:46:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lHUImak13K/Listeners', 04:46:02 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 04:46:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:46:02 INFO - 'USER': 'cltbld', 04:46:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:46:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:46:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:02 INFO - 'XPC_FLAGS': '0x0', 04:46:02 INFO - 'XPC_SERVICE_NAME': '0', 04:46:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:46:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:02 INFO - Downloading/unpacking jsonschema==2.5.1 04:46:02 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 04:46:02 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 04:46:02 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 04:46:02 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 04:46:02 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 04:46:02 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 04:46:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:46:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:46:04 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 04:46:04 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 04:46:04 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 04:46:04 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 04:46:04 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 04:46:04 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 04:46:04 INFO - Downloading functools32-3.2.3-2.tar.gz 04:46:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:46:04 INFO - warning: no files found matching '*.txt' 04:46:04 INFO - no previously-included directories found matching 'build' 04:46:04 INFO - no previously-included directories found matching 'dist' 04:46:04 INFO - no previously-included directories found matching '.git*' 04:46:04 INFO - Installing collected packages: jsonschema, functools32 04:46:04 INFO - Running setup.py install for functools32 04:46:04 INFO - warning: no files found matching '*.txt' 04:46:04 INFO - no previously-included directories found matching 'build' 04:46:04 INFO - no previously-included directories found matching 'dist' 04:46:04 INFO - no previously-included directories found matching '.git*' 04:46:04 INFO - Successfully installed jsonschema functools32 04:46:04 INFO - Cleaning up... 04:46:04 INFO - Return code: 0 04:46:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:46:04 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')]} 04:46:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:46:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:05 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 0x10c58cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c58f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0504cdda0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c36ad30>, '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 0x10c290db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c35fbe8>, '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.OQoKw3BQDd/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.lHUImak13K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 04:46:05 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 04:46:05 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 04:46:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OQoKw3BQDd/Render', 04:46:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:46:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:46:05 INFO - 'HOME': '/Users/cltbld', 04:46:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:46:05 INFO - 'LOGNAME': 'cltbld', 04:46:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:05 INFO - 'MOZ_NO_REMOTE': '1', 04:46:05 INFO - 'NO_EM_RESTART': '1', 04:46:05 INFO - 'PAGER': '/bin/cat', 04:46:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:46:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:05 INFO - 'PWD': '/builds/slave/test', 04:46:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:46:05 INFO - 'SHELL': '/bin/bash', 04:46:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lHUImak13K/Listeners', 04:46:05 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 04:46:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:46:05 INFO - 'USER': 'cltbld', 04:46:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:46:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:46:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:05 INFO - 'XPC_FLAGS': '0x0', 04:46:05 INFO - 'XPC_SERVICE_NAME': '0', 04:46:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:46:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:05 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:46:05 INFO - Cleaning up... 04:46:05 INFO - Return code: 0 04:46:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:46:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:46:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:46:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c58cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c58f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0504cdda0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c36ad30>, '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 0x10c290db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c35fbe8>, '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.OQoKw3BQDd/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.lHUImak13K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 04:46:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:46:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:46:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OQoKw3BQDd/Render', 04:46:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:46:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:46:06 INFO - 'HOME': '/Users/cltbld', 04:46:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:46:06 INFO - 'LOGNAME': 'cltbld', 04:46:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:06 INFO - 'MOZ_NO_REMOTE': '1', 04:46:06 INFO - 'NO_EM_RESTART': '1', 04:46:06 INFO - 'PAGER': '/bin/cat', 04:46:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:46:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:06 INFO - 'PWD': '/builds/slave/test', 04:46:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:46:06 INFO - 'SHELL': '/bin/bash', 04:46:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lHUImak13K/Listeners', 04:46:06 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 04:46:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:46:06 INFO - 'USER': 'cltbld', 04:46:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:46:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:46:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:06 INFO - 'XPC_FLAGS': '0x0', 04:46:06 INFO - 'XPC_SERVICE_NAME': '0', 04:46:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:46:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:06 INFO - Downloading/unpacking blobuploader==1.2.4 04:46:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:08 INFO - Downloading blobuploader-1.2.4.tar.gz 04:46:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:46:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:46:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:46:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:46:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:08 INFO - Downloading docopt-0.6.1.tar.gz 04:46:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:46:09 INFO - Installing collected packages: blobuploader, requests, docopt 04:46:09 INFO - Running setup.py install for blobuploader 04:46:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:46:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:46:09 INFO - Running setup.py install for requests 04:46:09 INFO - Running setup.py install for docopt 04:46:09 INFO - Successfully installed blobuploader requests docopt 04:46:09 INFO - Cleaning up... 04:46:09 INFO - Return code: 0 04:46:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:46: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')]} 04:46:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46: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')]} 04:46:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:09 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 0x10c58cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c58f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0504cdda0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c36ad30>, '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 0x10c290db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c35fbe8>, '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.OQoKw3BQDd/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.lHUImak13K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 04:46:09 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 04:46:09 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 04:46:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OQoKw3BQDd/Render', 04:46:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:46:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:46:09 INFO - 'HOME': '/Users/cltbld', 04:46:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:46:09 INFO - 'LOGNAME': 'cltbld', 04:46:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:09 INFO - 'MOZ_NO_REMOTE': '1', 04:46:09 INFO - 'NO_EM_RESTART': '1', 04:46:09 INFO - 'PAGER': '/bin/cat', 04:46:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:46:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:09 INFO - 'PWD': '/builds/slave/test', 04:46:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:46:09 INFO - 'SHELL': '/bin/bash', 04:46:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lHUImak13K/Listeners', 04:46:09 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 04:46:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:46:09 INFO - 'USER': 'cltbld', 04:46:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:46:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:46:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:09 INFO - 'XPC_FLAGS': '0x0', 04:46:09 INFO - 'XPC_SERVICE_NAME': '0', 04:46:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:46:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:46:10 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-oodPAZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:46:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:46:10 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-I3XJvM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:46:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:46:10 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-DDfurR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:46:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:46:10 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-eTVLwh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:46:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:46:10 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-Y8yt6Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:46:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:46:10 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-FNwE7Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:46:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:46:10 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-glDGmK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:46:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:46:10 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-vTgZm7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:46:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:46:10 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-mU21hH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:46:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:46:11 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-GqRy7A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:46:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:46:11 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-FmyL7P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:46:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:46:11 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-5m5zdp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:46:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:46:11 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-dTBMx0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:46:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:46:11 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-jZzFqS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:46:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:46:11 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-_KuzNO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:46:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:46:11 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-6hUXIM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:46:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:46:11 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-6XTZQP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:46:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:46:11 INFO - Running setup.py install for manifestparser 04:46:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:46:12 INFO - Running setup.py install for mozcrash 04:46:12 INFO - Running setup.py install for mozdebug 04:46:12 INFO - Running setup.py install for mozdevice 04:46:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:46:12 INFO - Running setup.py install for mozfile 04:46:12 INFO - Running setup.py install for mozhttpd 04:46:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:46:12 INFO - Running setup.py install for mozinfo 04:46:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:46:12 INFO - Running setup.py install for mozInstall 04:46:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:46:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:46:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:46:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:46:13 INFO - Running setup.py install for mozleak 04:46:13 INFO - Running setup.py install for mozlog 04:46:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:46:13 INFO - Running setup.py install for moznetwork 04:46:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:46:13 INFO - Running setup.py install for mozprocess 04:46:13 INFO - Running setup.py install for mozprofile 04:46:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:46:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:46:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:46:13 INFO - Running setup.py install for mozrunner 04:46:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:46:14 INFO - Running setup.py install for mozscreenshot 04:46:14 INFO - Running setup.py install for moztest 04:46:14 INFO - Running setup.py install for mozversion 04:46:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:46:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:46:14 INFO - Cleaning up... 04:46:14 INFO - Return code: 0 04:46:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:46:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:46:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:46:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:14 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 0x10c58cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c58f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0504cdda0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c36ad30>, '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 0x10c290db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c35fbe8>, '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.OQoKw3BQDd/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.lHUImak13K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 04:46:14 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 04:46:14 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 04:46:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OQoKw3BQDd/Render', 04:46:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:46:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:46:14 INFO - 'HOME': '/Users/cltbld', 04:46:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:46:14 INFO - 'LOGNAME': 'cltbld', 04:46:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:14 INFO - 'MOZ_NO_REMOTE': '1', 04:46:14 INFO - 'NO_EM_RESTART': '1', 04:46:14 INFO - 'PAGER': '/bin/cat', 04:46:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:46:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:14 INFO - 'PWD': '/builds/slave/test', 04:46:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:46:14 INFO - 'SHELL': '/bin/bash', 04:46:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lHUImak13K/Listeners', 04:46:14 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 04:46:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:46:14 INFO - 'USER': 'cltbld', 04:46:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:46:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:46:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:14 INFO - 'XPC_FLAGS': '0x0', 04:46:14 INFO - 'XPC_SERVICE_NAME': '0', 04:46:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:46:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:46:14 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-ERx91S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:46:14 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)) 04:46:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:46:14 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-fkZteA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:46:14 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)) 04:46:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:46:14 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-73vfYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:46:15 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)) 04:46:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:46:15 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-qX47lQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:46:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 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)) 04:46:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:46:15 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-haiCed-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:46:15 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)) 04:46:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:46:15 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-LHZ2wr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:46:15 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)) 04:46:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:46:15 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-VIs2Nz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:46:15 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)) 04:46:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:46:15 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-GNkBZh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:46:15 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)) 04:46:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:46:15 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-OlOgJk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:46:15 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)) 04:46:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:46:15 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-E2AyPR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:46:15 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)) 04:46:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:46:15 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-6BdJo0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:46:15 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)) 04:46:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:46:15 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-00SYUY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:46:16 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)) 04:46:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:46:16 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-Sx0l2Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:46:16 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)) 04:46:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:46:16 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-0nceVe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:46:16 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)) 04:46:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:46:16 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-9QlcAB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:46:16 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)) 04:46:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:46:16 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-KSxbHZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:46:16 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)) 04:46:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:46:16 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-oOMnnw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:46:16 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)) 04:46:16 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)) 04:46:16 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)) 04:46:16 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)) 04:46:16 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:46:16 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:46:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:46:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:17 INFO - Downloading blessings-1.6.tar.gz 04:46:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:46:18 INFO - Installing collected packages: blessings 04:46:18 INFO - Running setup.py install for blessings 04:46:18 INFO - Successfully installed blessings 04:46:18 INFO - Cleaning up... 04:46:18 INFO - Return code: 0 04:46:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:46:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:46:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:46:18 INFO - Reading from file tmpfile_stdout 04:46:18 INFO - Current package versions: 04:46:18 INFO - blessings == 1.6 04:46:18 INFO - blobuploader == 1.2.4 04:46:18 INFO - docopt == 0.6.1 04:46:18 INFO - functools32 == 3.2.3-2 04:46:18 INFO - jsonschema == 2.5.1 04:46:18 INFO - manifestparser == 1.1 04:46:18 INFO - mozInstall == 1.12 04:46:18 INFO - mozcrash == 1.0 04:46:18 INFO - mozdebug == 0.1 04:46:18 INFO - mozdevice == 0.50 04:46:18 INFO - mozfile == 1.2 04:46:18 INFO - mozhttpd == 0.7 04:46:18 INFO - mozinfo == 0.9 04:46:18 INFO - mozleak == 0.1 04:46:18 INFO - mozlog == 3.4 04:46:18 INFO - moznetwork == 0.27 04:46:18 INFO - mozprocess == 0.25 04:46:18 INFO - mozprofile == 0.28 04:46:18 INFO - mozrunner == 6.13 04:46:18 INFO - mozscreenshot == 0.1 04:46:18 INFO - mozsystemmonitor == 0.3 04:46:18 INFO - moztest == 0.8 04:46:18 INFO - mozversion == 1.4 04:46:18 INFO - psutil == 3.1.1 04:46:18 INFO - requests == 1.2.3 04:46:18 INFO - wsgiref == 0.1.2 04:46:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:46:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:46:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:46:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:18 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 0x10c58cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c58f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0504cdda0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c36ad30>, '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 0x10c290db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c35fbe8>, '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.OQoKw3BQDd/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.lHUImak13K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 04:46:18 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 04:46:18 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 04:46:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OQoKw3BQDd/Render', 04:46:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:46:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:46:18 INFO - 'HOME': '/Users/cltbld', 04:46:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:46:18 INFO - 'LOGNAME': 'cltbld', 04:46:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:18 INFO - 'MOZ_NO_REMOTE': '1', 04:46:18 INFO - 'NO_EM_RESTART': '1', 04:46:18 INFO - 'PAGER': '/bin/cat', 04:46:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:46:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:18 INFO - 'PWD': '/builds/slave/test', 04:46:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:46:18 INFO - 'SHELL': '/bin/bash', 04:46:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lHUImak13K/Listeners', 04:46:18 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 04:46:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:46:18 INFO - 'USER': 'cltbld', 04:46:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:46:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:46:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:18 INFO - 'XPC_FLAGS': '0x0', 04:46:18 INFO - 'XPC_SERVICE_NAME': '0', 04:46:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:46:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:18 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)) 04:46:18 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)) 04:46:18 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)) 04:46:18 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)) 04:46:18 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)) 04:46:18 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)) 04:46:18 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)) 04:46:18 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)) 04:46:18 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)) 04:46:18 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)) 04:46:18 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)) 04:46:18 INFO - Cleaning up... 04:46:18 INFO - Return code: 0 04:46:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:46:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:46:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:46:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c58cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c58f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0504cdda0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c36ad30>, '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 0x10c290db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c35fbe8>, '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.OQoKw3BQDd/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.lHUImak13K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 04:46:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:46:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:46:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OQoKw3BQDd/Render', 04:46:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:46:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:46:18 INFO - 'HOME': '/Users/cltbld', 04:46:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:46:18 INFO - 'LOGNAME': 'cltbld', 04:46:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:18 INFO - 'MOZ_NO_REMOTE': '1', 04:46:18 INFO - 'NO_EM_RESTART': '1', 04:46:18 INFO - 'PAGER': '/bin/cat', 04:46:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:46:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:18 INFO - 'PWD': '/builds/slave/test', 04:46:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:46:18 INFO - 'SHELL': '/bin/bash', 04:46:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lHUImak13K/Listeners', 04:46:18 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 04:46:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:46:18 INFO - 'USER': 'cltbld', 04:46:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:46:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:46:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:18 INFO - 'XPC_FLAGS': '0x0', 04:46:18 INFO - 'XPC_SERVICE_NAME': '0', 04:46:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:46:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:46:19 INFO - Cleaning up... 04:46:19 INFO - Return code: 0 04:46:19 INFO - Running post-action listener: _resource_record_post_action 04:46:19 INFO - Running post-action listener: _start_resource_monitoring 04:46:19 INFO - Starting resource monitoring. 04:46:19 INFO - [mozharness: 2017-05-04 11:46:19.079716Z] Finished create-virtualenv step (success) 04:46:19 INFO - [mozharness: 2017-05-04 11:46:19.080651Z] Running install step. 04:46:19 INFO - Running pre-action listener: _resource_record_pre_action 04:46:19 INFO - Running main action method: install 04:46:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:46:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:46:19 INFO - Reading from file tmpfile_stdout 04:46:19 INFO - Detecting whether we're running mozinstall >=1.0... 04:46:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:46:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:46:19 INFO - Reading from file tmpfile_stdout 04:46:19 INFO - Output received: 04:46:19 INFO - Usage: mozinstall [options] installer 04:46:19 INFO - Options: 04:46:19 INFO - -h, --help show this help message and exit 04:46:19 INFO - -d DEST, --destination=DEST 04:46:19 INFO - Directory to install application into. [default: 04:46:19 INFO - "/builds/slave/test"] 04:46:19 INFO - --app=APP Application being installed. [default: firefox] 04:46:19 INFO - mkdir: /builds/slave/test/build/application 04:46:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:46:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:46:38 INFO - Reading from file tmpfile_stdout 04:46:38 INFO - Output received: 04:46:38 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 04:46:38 INFO - Running post-action listener: _resource_record_post_action 04:46:38 INFO - [mozharness: 2017-05-04 11:46:38.951199Z] Finished install step (success) 04:46:38 INFO - [mozharness: 2017-05-04 11:46:38.951342Z] Running run-tests step. 04:46:38 INFO - Running pre-action listener: _resource_record_pre_action 04:46:38 INFO - Running main action method: run_tests 04:46:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:46:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:46:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:46:38 INFO - 2017-05-04 04:46:38.965 screenresolution[1645:7343] starting screenresolution argv=screenresolution get 04:46:38 INFO - 2017-05-04 04:46:38.968 screenresolution[1645:7343] Display 0: 1600x1200x32@60 04:46:38 INFO - 2017-05-04 04:46:38.974 screenresolution[1646:7345] starting screenresolution argv=screenresolution list 04:46:38 INFO - Available Modes on Display 0 04:46:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:46:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:46:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:46:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:46:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:46:39 INFO - Intel Iris: 04:46:39 INFO - Chipset Model: Intel Iris 04:46:39 INFO - Type: GPU 04:46:39 INFO - Bus: Built-In 04:46:39 INFO - VRAM (Dynamic, Max): 1536 MB 04:46:39 INFO - Vendor: Intel (0x8086) 04:46:39 INFO - Device ID: 0x0a2e 04:46:39 INFO - Revision ID: 0x0009 04:46:39 INFO - Displays: 04:46:39 INFO - Display: 04:46:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:46:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:46:39 INFO - Display Serial Number: 1600x1200 60 04:46:39 INFO - Main Display: Yes 04:46:39 INFO - Mirror: Off 04:46:39 INFO - Online: Yes 04:46:39 INFO - Rotation: Supported 04:46:39 INFO - Return code: 0 04:46:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:46:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:46:39 INFO - Python 2.7.3 04:46:39 INFO - Return code: 0 04:46:39 INFO - grabbing minidump binary from tooltool 04:46:39 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')]} 04:46:39 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 0x10c36ad30>, '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 0x10c290db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c35fbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:46:39 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 04:46:39 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 04:46:39 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 04:46:39 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:46:39 INFO - Return code: 0 04:46:39 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:46:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:46:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:46:39 INFO - ENV: RUST_BACKTRACE is now 1 04:46:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:46:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:46:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--title', 't-yosemite-r7-0278', '--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 04:46:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --title t-yosemite-r7-0278 --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 04:46:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OQoKw3BQDd/Render', 04:46:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:46:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:46:39 INFO - 'HOME': '/Users/cltbld', 04:46:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:46:39 INFO - 'LOGNAME': 'cltbld', 04:46:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:46:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:46:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:39 INFO - 'MOZ_NO_REMOTE': '1', 04:46:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:46:39 INFO - 'NO_EM_RESTART': '1', 04:46:39 INFO - 'PAGER': '/bin/cat', 04:46:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:46:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:39 INFO - 'PWD': '/builds/slave/test', 04:46:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:46:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:46:39 INFO - 'RUST_BACKTRACE': '1', 04:46:39 INFO - 'SHELL': '/bin/bash', 04:46:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lHUImak13K/Listeners', 04:46:39 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 04:46:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:46:39 INFO - 'USER': 'cltbld', 04:46:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:46:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:46:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:39 INFO - 'XPC_FLAGS': '0x0', 04:46:39 INFO - 'XPC_SERVICE_NAME': '0', 04:46:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:46:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--title', 't-yosemite-r7-0278', '--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 04:46:39 INFO - mozversion application_buildid: 20170504030320 04:46:39 INFO - mozversion application_changeset: 33b92d9c40562dab3d7b602368c75619f1d793f7 04:46:39 INFO - mozversion application_display_name: Nightly 04:46:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:46:39 INFO - mozversion application_name: Firefox 04:46:39 INFO - mozversion application_remotingname: firefox 04:46:39 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:46:39 INFO - mozversion application_vendor: Mozilla 04:46:39 INFO - mozversion application_version: 55.0a1 04:46:39 INFO - mozversion platform_buildid: 20170504030320 04:46:39 INFO - mozversion platform_changeset: 33b92d9c40562dab3d7b602368c75619f1d793f7 04:46:39 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:46:39 INFO - mozversion platform_version: 55.0a1 04:46:39 INFO - using testdate: 1493898399 04:46:39 INFO - actual date: 1493898399 04:46:39 INFO - starting webserver on 'localhost:49236' 04:46:39 INFO - SUITE-START | Running 2 tests 04:46:39 INFO - TEST-START | dromaeo_css 04:46:39 INFO - operating with platform_type : mac_ 04:46:39 INFO - Initialising browser for dromaeo_css test... 04:46:39 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/tmpx9Upa7/profile http://localhost:49236/getInfo.html) 04:46:42 INFO - PID 1656 | 2017-05-04 04:46:42.800 plugin-container[1660:7535] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b43, name = 'com.apple.tsm.portname' 04:46:42 INFO - PID 1656 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:46:42 INFO - PID 1656 | 2017-05-04 04:46:42.801 plugin-container[1660:7535] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4807, name = 'com.apple.CFPasteboardClient' 04:46:42 INFO - PID 1656 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:46:42 INFO - PID 1656 | 2017-05-04 04:46:42.801 plugin-container[1660:7535] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:46:42 INFO - PID 1656 | __metrics Screen width/height:1600/1200 04:46:42 INFO - PID 1656 | colorDepth:24 04:46:42 INFO - PID 1656 | Browser inner width/height: 1024/691 04:46:42 INFO - PID 1656 | __metrics 04:46:43 INFO - PID 1656 | 2017-05-04 04:46:43.246 plugin-container[1661:7579] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x3f4f, name = 'com.apple.tsm.portname' 04:46:43 INFO - PID 1656 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:46:43 INFO - PID 1656 | 2017-05-04 04:46:43.246 plugin-container[1661:7579] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8623, name = 'com.apple.CFPasteboardClient' 04:46:43 INFO - PID 1656 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:46:43 INFO - PID 1656 | 2017-05-04 04:46:43.246 plugin-container[1661:7579] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:46:44 INFO - TEST-INFO | 1656: exit 0 04:46:44 INFO - Browser initialized. 04:46:44 INFO - Running cycle 1/1 for dromaeo_css test... 04:46:44 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/tmpx9Upa7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:46:46 INFO - PID 1662 | 2017-05-04 04:46:46.528 plugin-container[1663:7703] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x884b, name = 'com.apple.tsm.portname' 04:46:46 INFO - PID 1662 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:46:46 INFO - PID 1662 | 2017-05-04 04:46:46.529 plugin-container[1663:7703] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c0b, name = 'com.apple.CFPasteboardClient' 04:46:46 INFO - PID 1662 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:46:46 INFO - PID 1662 | 2017-05-04 04:46:46.529 plugin-container[1663:7703] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:46:46 INFO - PID 1662 | 2017-05-04 04:46:46.901 plugin-container[1664:7744] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x3e47, name = 'com.apple.tsm.portname' 04:46:46 INFO - PID 1662 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:46:46 INFO - PID 1662 | 2017-05-04 04:46:46.901 plugin-container[1664:7744] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x860f, name = 'com.apple.CFPasteboardClient' 04:46:46 INFO - PID 1662 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:46:46 INFO - PID 1662 | 2017-05-04 04:46:46.901 plugin-container[1664:7744] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:46:56 INFO - PID 1662 | RSS: Main: 233037824 04:46:56 INFO - PID 1662 | 04:50:00 INFO - PID 1662 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49236/tests/dromaeo/cssquery-ext.html) 04:50:01 INFO - PID 1662 | RSS: Main: 250322944 04:50:01 INFO - PID 1662 | 04:53:03 INFO - PID 1662 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-ext.html (next: http://localhost:49236/tests/dromaeo/cssquery-jquery.html) 04:53:04 INFO - PID 1662 | RSS: Main: 254885888 04:53:04 INFO - PID 1662 | 04:56:06 INFO - PID 1662 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49236/tests/dromaeo/cssquery-mootools.html) 04:56:06 INFO - PID 1662 | RSS: Main: 267087872 04:56:06 INFO - PID 1662 | 04:59:08 INFO - PID 1662 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49236/tests/dromaeo/cssquery-prototype.html) 04:59:09 INFO - PID 1662 | RSS: Main: 263012352 04:59:09 INFO - PID 1662 | 05:02:11 INFO - PID 1662 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49236/tests/dromaeo/cssquery-yui.html) 05:02:12 INFO - PID 1662 | RSS: Main: 266571776 05:02:12 INFO - PID 1662 | 05:05:14 INFO - PID 1662 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-yui.html (next: http://localhost:49236/tests/dromaeo/cssquery-dojo.html) 05:05:14 INFO - PID 1662 | RSS: Main: 265261056 05:05:14 INFO - PID 1662 | 05:05:14 INFO - PID 1662 | __start_tp_report 05:05:14 INFO - PID 1662 | _x_x_mozilla_page_load 05:05:14 INFO - PID 1662 | _x_x_mozilla_page_load_details 05:05:14 INFO - PID 1662 | |i|pagename|runs| 05:05:14 INFO - PID 1662 | |0;dojo.html;2996.760259179266;3315.6187038490575;3562.127278816692;3611.2596917631886;3624.6737793598577;4380.934285985712;4670.486246512885;5585.050541407955;5996.6402015879075;6243;6125.845966769323;6144.187464697914;6200.10098535712;6201.596896201755;6237.03325984472;4252.957470425287;5317.308749862532;5369;5373.623846330758;5439.619226654136;5438.8912221755545;5464.153056276284;5473.726313684319;5497.175423686439;5510.5316048135755;5344.893102137936;5371.623986320959;5421.701806400646;5456.890862182734;5512.145617429305;5455.0453670607885;5477;5497.8075767348355;5498;5515.806946756885;5335.7865685372535;5368.677879327214;5379.757910894019;5411.107167317388;5419.3225846769155;6061.727222275008;6227.782027629011;6239.376062393724;6246.937530624681;6264.9686751566405;6370.936290637081;6454.515911306624;6592.637404942774;6649.80050598478;6651.800445986628;6762.120924279861;6768.052472653832;6774.983752437124;6775.525713200078;6784.966075169642;6243.7814676486105;6250.093736408196;6276.121343011982;6316.6841657917375;6323.52573556985;6304.716287767062;6669.7332106715185;6740.325967403319;6896.069030680794;6946.027556142144;6343.3339499351905;6396.584222025554;6491.902621460682;6506.772262970773;6600.867982640416;6603.504737144734;6699.330066993359;6712.228093769181;6730.293319201512;6748.358905903931;6624.27133015368;6627.701753421107;6647.202335719745;6654.334566543307;6670.4997125215805;6440.903386449207;6486.935130648728;6559.770408035696;6639.900401493981;6673.632950187786;5275.709835959059;5279.9208011879855;5290.259363689087;5309.017831701148;5333.679979201261;4548.340490628841;4665.4634717007975;4666.883327916829;4673.322368256584;4685.4143232095985;6242.687865606701;6269.185005949197;6329.715162817684;6341.175647165839;6360.936390636034;6691.5650482718465;6733.192016957996;6733.494987875831;6757.628330441775;6761.391474767294;6340.714667839959;6354.777582784673;6364.681765911779;6373.012183111625;6374.075759014917;5748.540116790647;5825.0679891217205;5894.32215295238;5901.232839730894;5931.6441013539325;5147.305113809737;6765.830854228684;6787.728490860311;6904.275051119761;6929.757458488929;5603.915941260802;5621.971890140523;6705.295943926013;6715.294894036056;6781.864362712817;6845.931540684529;6892.793216203522;6905.585664859924;6954.3393377629045;6967.7212911482975;5786.07422812348;6120.571559990758;6280.905786413116;6486.772962946275;6617;5875.853103672443;6322;6632.966835165793;6711.597304161766;6731.024001519654;5347.545458636059;6091.238595175603;6199.969000154971;6442.742290308335;6449.806505804833;5554.944450555443;6496.9025464617125;6525;6531.2489063756375;6568.540202185801;6238.220222472191;6419.261784894797;6444.9355506444335;6475.579087359307;6533.509986750918;5453.509184173444;6356.4279214870885;6446.258680251831;6455.289918108911;6555.475561955128;5094.5160209780015;6377.8724425512155;6437.839054023687;6445.226572811105;6448.871022579616 05:05:14 INFO - PID 1662 | |1;ext.html;730.7734602273296;734.342763226912;808.4906508899394;1142.8514293141895;1274.1208566089404;36606.26787464252;37844.24311513768;37926.62073379269;37982.43026354603;38025.80987095061;29354.85322573384;38125;38153;38171;38214.80892595533;7775.339096176817;7957.403194760387;8348.332133429341;8583.442076265053;8623.482591044558;8529.10444403338;8567.143285671445;8631.136886311382;8633.13668633138;8633.13668633138;8595.312375010015;8613.138686131399;8676.045634980179;8683.261922736543;8684.218420342168;8616.526091064989;8631;8633.52515611638;8639.35204859638;8654.783630409227;8343.707970221074;8360.874586881202;8424.747257582283;8440.57797110142;8447.070822209553;37332.880013599366;37487.812560937295;37773.244535109145;37785;37886.24227515462;3484.494748261488;3603.387424137903;3610.097475631092;3611.765235259726;3616.8372423240753;30627.23431914198;30827.537586936214;30875.536866947015;30906;31033;3123.6095488063993;3131.123285480069;3163.3234385775577;3172.460681684096;3180.6024246969127;252496.68758281006;280869;281092;325128.7435628209;326718;38684.61315386866;47270.05459890783;47514.52485475101;47692.76153619279;47696.5230347699;50010;50026.74933126701;56480;56574.71712641411;56961.145582816294;14623.488177913934;14648.707025859423;14732.77900831467;14762.966592338647;14785.89105817068;11568.652940411801;11699.824502632468;11770.76458470843;11776.11679124069;11790.292582445081;14313.64215894611;14317.498887538886;14366.35351409189;14415.927920360331;14447.638809029859;5100.897982040338;6130.478909292671;6144.38556144382;6181.690915454209;6195.070739389128;912.9090736569868;947.7630592351912;982.219135787051;1051.6792378324685;1081.3079629037422;19311;20519.17923283052;22763.658545121838;25189.87405062963;25291.241262762145;1138.5218208352512;1150.5340337163461;1171.3147808532103;1176.623480486236;1188.441432526711;11107.44462776874;12348.814767778491;12760.361981900867;12950.352482375843;13082.607521774362;279931;348437;349721;350324;350584;54111.72944135254;54494.45505544973;54596.72701636466;54600.180997285075;54870.72564637231;1356.3218390804598;1511.6749898771816;1536.0860288128545;1567.851054149854;1572.2688949638243;21882.781172188075;24338.391540211636;24402.389940251636;24470.877645611657;24577.63133553034;37858;38014.239715206095;38067.61932380641;38091.85724428271;38336;280885;281898.59050704614;282039;282905.5854720713;283271;34823.825880870434;35633;35890;36624.81687591545;36681.44977825388;45124;45782.08435831198;46546.76726616345;46583.30125048195;46808;29373.412531749673;31071.68928310688;31154;31572.526412103376;31954.40227988545;25649.487010260065;28101.57847632328;30885.918992836043;31791.682083178872;31936.52095218527;37334.43998339973;37744.433833493065;37972;38104.80947595244;38316.42525362066;23566.057357706184;29494.852525737235;30589.54115688311;31721;31840.52239216367;23621.881890590437;24304;25049.761295439832;25162;25176.49647007013 05:05:14 INFO - PID 1662 | |2;jquery.html;431.6093934988836;439.07355479937326;441.9658000279348;453.53512649534224;458.63996762541393;17394.652106957852;17870.463886083406;19111.42665720027;20821;21715;22206.444838879037;23430.41423964402;23437.296881093593;23488.647670284958;23598.410039749015;6107.541934354919;6251.562390632657;6253.499720022387;6265.530085243602;6299.937000630004;4890.975545122269;5393.1370980643105;5986.700664966756;6179.7837075702355;6187.721552530124;4890.951090489085;5864.530837532987;6163.044728067157;6164.383561643845;6168.290646575656;5953.58324917256;6094.847628809271;6108.602940808833;6150.784722534712;6156.476699480527;4295.806688699016;5286.207068939651;5463.863403414906;5471.069918113891;5477.04151773438;28179;28544.571831422545;28701;29020.709792902013;29171.124866254046;2095.916163353464;2156.482444213393;2236.228501167111;2246.4945387287894;2249.3701763506083;17569.736453953203;17924.820751792446;18092.90953545237;18122.818771812246;18334;2025.159558783118;2130.9573808523896;2173.7608863025052;2175.216921908112;2183.8689678619335;155290.11774705723;164114.17942910327;169375;173385;176102;12751.553695620609;12817.807732884014;13071.803922941164;13106.80339794904;13209;16849.41027064047;16875.409360672318;16886.91556542234;16892.40876569314;16913.661726765396;8797.38418310712;9119.452832829918;9143.268538517035;9308.30187735909;9329.393589416666;8758.080401557872;8779.165979231962;8818;8981.05698901619;8984.371094023487;7889.566073865878;8037.276645101969;8037.638306276232;8067.798305042421;8106.351491880635;2220.4448887778058;2229.8885055747146;2234.1510226113974;2246.449619843149;2406.205952035824;963.9469829159324;980.6763767956558;986.4574484033752;1007.6422869881234;1033.5555711044324;21168.78831211699;21716.348509544423;21848.563028739653;21884.343469695934;21913.452163695718;901.3915606965272;982.9017098290113;1015.9224386130381;1036.7356324137297;1052.6684094510206;10559.049685528185;11268.816774238587;11290.54837806495;11301.886981130248;11326.546938122383;529009;534909;535187;567133;567534;128643;142701.5729842709;143165.28417358056;145743;149576.51270461903;1211.8364020857248;1241.422738426636;1257.094891677972;1257.25821765159;1264.8166015927823;18585.34951276699;18838;22116.778832211472;22950.655740164246;23475.41311467227;59212.70393648177;59312.703436482545;59724.50688732816;59780.40219597922;60373;82901;83718;83924.74112888434;85166;85477.57261213654;8940.061293564342;9172.587233574372;9256.768580785265;9261.44431334122;9268.490233037248;14121.435142594592;14170.220637865017;14536.273186340852;14684.118952862862;14736.852631473548;11857.16999810005;11989;12040.819387709367;12082.939585302018;12095.246189302326;11336;11412.600558980395;11468.197226194086;11615.883841161818;11799.941000294944;10909.690837099599;11352.829707554229;11948.46231919583;12173.939130304292;12220.633380998584;7492.475526713078;8577.65689372443;9046.683366082156;9169.495677737521;9243.96632740796;9989.650362237287;10688.251822372671;11549.82675259855;11865.822012669989;12136.635900922987 05:05:14 INFO - PID 1662 | |3;mootools.html;1414.497853262092;1445.0968144909425;1451.8838492920568;1457.8542145785423;1459.7883756482122;9247.768805779859;9930.851037234448;11425.371604561746;11930.284182949019;11957.342346170968;11810.468528916197;11982.340971246578;12019.639410817668;12023.879761202385;12070.155089143764;2526.8862901169446;2564.2050964201158;2565.6921169459692;2566.3199252198183;2575.5364034473787;2480.8139389545854;2523.5962246040544;2524.406764410362;2534.797216222707;2538.1370334086405;2069.379186244121;2090.1848279171136;2343.1096183450263;2491.6262560615874;2538.7968962482955;2463.4334103156284;2472.7032756069207;2507.523570521595;2510.648509208694;2517.622356646499;2037.521182522106;2413.505231427571;2507.6238564215514;2518.420763224469;2526.178991827663;11802.232854864405;11893.04855611549;11906;11908.880911190863;11961.820572691417;6591.373819487189;6849.520533562652;6861.730579842745;6862.794116176523;6863.862722745517;3997.960020399817;4361.956380436219;4407.206702793496;4418.712783669083;4447.221736196153;1267.854196767365;1276.7318863038772;1305.8106574546637;1316.6642506160963;1319.3996731487246;14679.926600367036;15285.847141528664;15865.603359916095;16797.58006049846;16990;5022.698638081727;5024.49755024502;5490.725463726798;5713.914291285634;5724.914126288109;11894.643160705193;11998.280103193661;12009.939950300193;12022.338771367658;12029.819552706716;6248.843778905563;6347.047942808524;6350.587211831216;6352.8411789704705;6367.554271200971;5964.85087872798;5985.401459854067;6048.425399587032;6068.787592434243;6142.140100385949;4306.009617787864;4388.561143885586;4391.253486907233;4408.228560001987;4410.448693913261;1006.5671761142779;1199.5861427807392;1223.253815172744;1281.9807702884464;1298.4222021200665;799.4923223752959;813.2721214512977;831.1273163178638;840.7898025493627;860.767592749954;6050.878982420327;6174.38256174388;6217.689115544295;6310.463610593151;6467.611943283418;532.9227262046982;599.5024129972113;619.6986328709763;621.6860485454816;632.3360471504993;4082.6121518455698;4182.665386769051;4275.551067137968;4353.695241333076;4378.912421751547;14761.261936903113;15265.618359540878;15279.38882444712;15289.311980960661;15307.234638268043;14966.476173333882;15105.39578416851;15126.092434453967;15166.696666066617;15177;8182.631781569844;8546.871796923051;8758.693445729496;8767.649294028168;8793.428427152214;6505.447037001908;7066.858662826612;7118.039064726196;7191.604461754654;7264.309890560388;10935.56257749681;11138;13397.665058373228;13715.519956801463;13898.930505347409;13761.31193440344;13941.95435342333;13995.650108747363;14093.083949543246;14311.499097531536;9325.533723313943;9334.439933604006;9396.76508087276;9511.334206605748;9512.90487095148;8944.37389382737;10652.254342195973;10742.785144297226;10788.460576971276;10836.729081773019;8625.353098517511;8819.867701984347;8850.867236991322;8869.157430044135;8889.955550222208;8131.9593402032615;8509.829803403773;9031.503267320099;9103.453792772454;9110.726678199664;8270;8315.584220789058;8393.748187554384;8409.495430274203;8438.198371154731;5047.848564543069;6167.722452489738;6184.6598437086395;6203.2556093269095;6267.809116267895;6095;6100.328963814066;6277.085488925922;6295.905561416674;6425.614463132227 05:05:14 INFO - PID 1662 | |4;prototype.html;348.2286734882236;389.45281878960054;414.9128682976575;416.0908415112979;418.4079527468634;5268.341457317835;5423.945760542393;6122.87754244916;6368.426841584268;6410.455111315532;5243.2659427680155;5924.940750592504;6038.4867286280605;6158.59969102008;6161.938380616204;3884.553276373225;4480.7087539310005;4508.549145085498;4528.592426681598;4556.134334476439;4294.871153865389;4479.932801007987;4480.364666896576;4480.395146655193;4537.931931021021;3691;4432.20220360335;4450.399196108517;4471.630036080883;4476.239039363316;4468.329750537429;4472.284434490466;4480.6639502037315;4503.5946764791;4509.932351014738;3137.592113025315;3778.9811050944845;3801.9279492676555;3826.540815102178;3867.7679339239735;4653.441587009581;5965.343812180657;5979.312379076375;6010.338862725097;6046.667433291167;5362.276092727471;5378.2470454136455;5383.2732581101445;5396.568274538027;5404.486573775524;5995.760169593211;6517.93482065178;6527.738890444377;6591.901121483182;6605.042268871035;4356.564343565618;4367.54140815213;4373.934390984138;4378.16814805186;4387.868363949086;6430.582012169194;6638.892219158386;6726.022743170019;6946.444284457231;7080.92919070813;4369.519352871182;4406.449193850769;4411.338299255138;4416.1609294233995;4436.844710435119;3794.5256842894637;4466.218411777926;4498.3010193884065;4503.887402814956;4514.029483660963;4254.468191476066;4646.465656449484;5297.602679799031;5304.416514183436;5352.484332363782;5409.269748583891;6316.021016742412;6356.809295721136;6399.680015999182;6615.750644780797;1405.1358414575168;1422.4168091082606;1430.499325236159;1478.4160256698758;1586.912719800399;936.0592604432638;963.3449254507002;1003.8066823989606;1008.1783346572666;1012.9189664826796;6261.3407447026575;6319.494440444753;6338.271098823694;6374.904376434357;6377.4579160771855;6157.630542167395;6311.968440157862;6853.897191542131;6866.485013623998;6870.656467176721;6197;6298;6308.52686048539;6328.240611126695;6346.7476790550445;3155.49512078071;3201.519772034167;3459.6367381425093;3503.5095086687884;3610.494530765695;6069.3627169147485;6599.8350041248395;7032.015517827406;7062.081929349151;7107.92892071083;6097.664628445478;6983.057287266256;7079.752208672775;7100.112485939258;7101.538400003983;7026.92973070273;7114.466415018895;7239.276072392824;7272;7276.344134391015;5375.35495740498;5996.580239383201;6590.50571207171;6840.794776156723;7099.254578269208;6638.236602790741;6700.961350990604;6725;6859.348361905611;6905;7237.276272372721;7246.4202863771825;7252.311030452099;7256.637168141678;7429.034225550644;3909.804509774443;4355.715064056048;4373.781310934377;4440.245158323029;4459.687821852439;6819.727210911508;6921.169459664872;6981.650917454209;6985.79042628722;6987.895181572382;6141.662208578571;6691.197056353269;6713.697883595152;6728.880402673338;6751.615918736746;6488.837779055372;6634.800955971328;6720.260771315054;6722.159730033746;6761.695723692347;5446.0122055450265;5724.3703192647945;6609.438197753245;6611.322414422167;6612.437942774918;6404.743810247538;6627.635480048643;6683.8663226734225;6745;6779.220389655253;6599.175103112111;6601;6607.372299631527;6629.834254143492;6651.866962660622 05:05:14 INFO - PID 1662 | |5;yui.html;790.8774140008301;831.4013909984809;836.8033512124649;863.7499314286284;873.8596132047677;14424.783628245585;15001.249937503137;16409.671806563878;16870.325186992523;16875.915620421896;12425.502979880817;13144.60566183016;17300.653986920253;17303.96176229427;17335.653286934255;983.6409710455704;984.8867380251273;991.459654488302;991.4893829677721;995.1193194023269;990.7374545745383;1018.0837246478192;1018.5365658625345;1020.5305559442666;1021.2442792333694;981.6024510073431;1013.0123129948315;1049.4437947887632;1056.0495554001384;1058.6241884131139;784.8901153838467;1029.8970102989679;1045.7385653586603;1049.5014867937707;1051.2431049644244;777.7744454108301;781.1329424338979;786.5595266650694;787.0712559180165;790.0440467034895;13808.654783630389;16863.57841053971;17039.914800426042;17081.402150924783;17266.91366543172;17182.74225886613;17324.826751732446;17330.913345433193;17629.471115866418;17671.293148274053;13815;13931.860681393158;13989.160650361011;14092.718145637133;14154.292285385793;3495.667911548399;3525;3525.7884526928465;3527.276908233806;3531.9293614127832;104572;131791;132175;135913.82835485943;136865;13403.664908377368;13533.45866165362;13543.59369218925;13605.387757550934;13763.243021633907;25789.3552661185;25918.870405647853;26246;26257.737422625913;26299.605505917425;7585.127710313274;7642.579658118746;7683.308502234826;7695.384369250559;7725.575093369918;3758.8496460141837;3823.292690852146;3830.9808450957566;3831.750936189139;3835.328817456934;4390.582894625006;4418.381426600278;4441.533638967927;4489.595936365743;4497.910041799146;872.9476231426135;890.412327863607;890.6259371064168;893.1559676106148;897.1880448194395;648.3905129178557;658.3120638932327;665.3180489997694;669.6183175589964;681.2608319972885;11005.669829904955;11658.607109028231;11935.343556104497;11947.223430476992;12010.63968080959;650.8795872763554;656.4780999105723;656.8883289840738;670.6009924095156;683.9760608378782;4653.744044077608;4778.972520907952;5404.83785486436;5484.808031718871;5564.693941833238;106430;108418.45790770996;111240.4437977821;111666;114172;92863.49510876587;94269.5286523563;94999.97500237466;95799.0420095804;96134.51932740431;87014;87471;88093;88272.5586372064;92279.53860230657;8571.785705357415;10894.945525272324;11071.05895998817;11166.44167791591;11188.496517656562;42860;42916.78541607272;43647.56352436435;43837.56162438462;44187;55736.885262295335;56616.43383566276;56768.432315677965;57009;57149;13512;13618.38717257706;13647.727045458836;13791.793123102962;14074.225917574631;15103.244837758288;15108.39566417331;15275.465358712392;15430.84569154339;15452.5364239073;16035.198240088183;17084.316627334767;17272.309107635552;17373.391931282345;17374.131293435024;15689;15877.737627023917;16180.621824304182;16217.432389866299;16484.505464835594;15634;15873.761893571836;16483.093429861474;16631.085290308663;16642.833571664127;11421.31472111676;11723.296602203895;11963.700907477383;12116.575919842764;12232.938835305766;12756.61730148097;12840.486380545048;12856.100072995174;12908.935455322664;12964.416601253155 05:05:14 INFO - PID 1662 | __end_tp_report 05:05:14 INFO - PID 1662 | __start_cc_report 05:05:14 INFO - PID 1662 | _x_x_mozilla_cycle_collect,408 05:05:14 INFO - PID 1662 | __end_cc_report 05:05:14 INFO - PID 1662 | __startTimestamp1493899514542__endTimestamp 05:05:14 INFO - PID 1662 | 05:05:14 INFO - PID 1662 | ------- Summary: start ------- 05:05:14 INFO - PID 1662 | Number of tests: 6 05:05:14 INFO - PID 1662 | 05:05:14 INFO - PID 1662 | [#0] dojo.html Cycles:165 Average:6051.46 Median:6323.53 stddev:770.96 (12.2%) stddev-sans-first:735.14 05:05:14 INFO - PID 1662 | Values: 2996.8 3315.6 3562.1 3611.3 3624.7 4380.9 4670.5 5585.1 5996.6 6243.0 6125.8 6144.2 6200.1 6201.6 6237.0 4253.0 5317.3 5369.0 5373.6 5439.6 5438.9 5464.2 5473.7 5497.2 5510.5 5344.9 5371.6 5421.7 5456.9 5512.1 5455.0 5477.0 5497.8 5498.0 5515.8 5335.8 5368.7 5379.8 5411.1 5419.3 6061.7 6227.8 6239.4 6246.9 6265.0 6370.9 6454.5 6592.6 6649.8 6651.8 6762.1 6768.1 6775.0 6775.5 6785.0 6243.8 6250.1 6276.1 6316.7 6323.5 6304.7 6669.7 6740.3 6896.1 6946.0 6343.3 6396.6 6491.9 6506.8 6600.9 6603.5 6699.3 6712.2 6730.3 6748.4 6624.3 6627.7 6647.2 6654.3 6670.5 6440.9 6486.9 6559.8 6639.9 6673.6 5275.7 5279.9 5290.3 5309.0 5333.7 4548.3 4665.5 4666.9 4673.3 4685.4 6242.7 6269.2 6329.7 6341.2 6360.9 6691.6 6733.2 6733.5 6757.6 6761.4 6340.7 6354.8 6364.7 6373.0 6374.1 5748.5 5825.1 5894.3 5901.2 5931.6 5147.3 6765.8 6787.7 6904.3 6929.8 5603.9 5622.0 6705.3 6715.3 6781.9 6845.9 6892.8 6905.6 6954.3 6967.7 5786.1 6120.6 6280.9 6486.8 6617.0 5875.9 6322.0 6633.0 6711.6 6731.0 5347.5 6091.2 6200.0 6442.7 6449.8 5554.9 6496.9 6525.0 6531.2 6568.5 6238.2 6419.3 6444.9 6475.6 6533.5 5453.5 6356.4 6446.3 6455.3 6555.5 5094.5 6377.9 6437.8 6445.2 6448.9 05:05:14 INFO - PID 1662 | 05:05:14 INFO - PID 1662 | [#1] ext.html Cycles:180 Average:45574.49 Median:350454.00 stddev:80195.60 (22.9%) stddev-sans-first:80349.89 05:05:14 INFO - PID 1662 | Values: 730.8 734.3 808.5 1142.9 1274.1 36606.3 37844.2 37926.6 37982.4 38025.8 29354.9 38125.0 38153.0 38171.0 38214.8 7775.3 7957.4 8348.3 8583.4 8623.5 8529.1 8567.1 8631.1 8633.1 8633.1 8595.3 8613.1 8676.0 8683.3 8684.2 8616.5 8631.0 8633.5 8639.4 8654.8 8343.7 8360.9 8424.7 8440.6 8447.1 37332.9 37487.8 37773.2 37785.0 37886.2 3484.5 3603.4 3610.1 3611.8 3616.8 30627.2 30827.5 30875.5 30906.0 31033.0 3123.6 3131.1 3163.3 3172.5 3180.6 252496.7 280869.0 281092.0 325128.7 326718.0 38684.6 47270.1 47514.5 47692.8 47696.5 50010.0 50026.7 56480.0 56574.7 56961.1 14623.5 14648.7 14732.8 14763.0 14785.9 11568.7 11699.8 11770.8 11776.1 11790.3 14313.6 14317.5 14366.4 14415.9 14447.6 5100.9 6130.5 6144.4 6181.7 6195.1 912.9 947.8 982.2 1051.7 1081.3 19311.0 20519.2 22763.7 25189.9 25291.2 1138.5 1150.5 1171.3 1176.6 1188.4 11107.4 12348.8 12760.4 12950.4 13082.6 279931.0 348437.0 349721.0 350324.0 350584.0 54111.7 54494.5 54596.7 54600.2 54870.7 1356.3 1511.7 1536.1 1567.9 1572.3 21882.8 24338.4 24402.4 24470.9 24577.6 37858.0 38014.2 38067.6 38091.9 38336.0 280885.0 281898.6 282039.0 282905.6 283271.0 34823.8 35633.0 35890.0 36624.8 36681.4 45124.0 45782.1 46546.8 46583.3 46808.0 29373.4 31071.7 31154.0 31572.5 31954.4 25649.5 28101.6 30885.9 31791.7 31936.5 37334.4 37744.4 37972.0 38104.8 38316.4 23566.1 29494.9 30589.5 31721.0 31840.5 23621.9 24304.0 25049.8 25162.0 25176.5 05:05:14 INFO - PID 1662 | 05:05:14 INFO - PID 1662 | [#2] jquery.html Cycles:180 Average:36606.32 Median:2247.93 stddev:93789.00 (4172.2%) stddev-sans-first:94012.78 05:05:14 INFO - PID 1662 | Values: 431.6 439.1 442.0 453.5 458.6 17394.7 17870.5 19111.4 20821.0 21715.0 22206.4 23430.4 23437.3 23488.6 23598.4 6107.5 6251.6 6253.5 6265.5 6299.9 4891.0 5393.1 5986.7 6179.8 6187.7 4891.0 5864.5 6163.0 6164.4 6168.3 5953.6 6094.8 6108.6 6150.8 6156.5 4295.8 5286.2 5463.9 5471.1 5477.0 28179.0 28544.6 28701.0 29020.7 29171.1 2095.9 2156.5 2236.2 2246.5 2249.4 17569.7 17924.8 18092.9 18122.8 18334.0 2025.2 2131.0 2173.8 2175.2 2183.9 155290.1 164114.2 169375.0 173385.0 176102.0 12751.6 12817.8 13071.8 13106.8 13209.0 16849.4 16875.4 16886.9 16892.4 16913.7 8797.4 9119.5 9143.3 9308.3 9329.4 8758.1 8779.2 8818.0 8981.1 8984.4 7889.6 8037.3 8037.6 8067.8 8106.4 2220.4 2229.9 2234.2 2246.4 2406.2 963.9 980.7 986.5 1007.6 1033.6 21168.8 21716.3 21848.6 21884.3 21913.5 901.4 982.9 1015.9 1036.7 1052.7 10559.0 11268.8 11290.5 11301.9 11326.5 529009.0 534909.0 535187.0 567133.0 567534.0 128643.0 142701.6 143165.3 145743.0 149576.5 1211.8 1241.4 1257.1 1257.3 1264.8 18585.3 18838.0 22116.8 22950.7 23475.4 59212.7 59312.7 59724.5 59780.4 60373.0 82901.0 83718.0 83924.7 85166.0 85477.6 8940.1 9172.6 9256.8 9261.4 9268.5 14121.4 14170.2 14536.3 14684.1 14736.9 11857.2 11989.0 12040.8 12082.9 12095.2 11336.0 11412.6 11468.2 11615.9 11799.9 10909.7 11352.8 11948.5 12173.9 12220.6 7492.5 8577.7 9046.7 9169.5 9244.0 9989.7 10688.3 11549.8 11865.8 12136.6 05:05:14 INFO - PID 1662 | 05:05:14 INFO - PID 1662 | [#3] mootools.html Cycles:180 Average:7074.19 Median:4290.78 stddev:4491.39 (104.7%) stddev-sans-first:4483.85 05:05:14 INFO - PID 1662 | Values: 1414.5 1445.1 1451.9 1457.9 1459.8 9247.8 9930.9 11425.4 11930.3 11957.3 11810.5 11982.3 12019.6 12023.9 12070.2 2526.9 2564.2 2565.7 2566.3 2575.5 2480.8 2523.6 2524.4 2534.8 2538.1 2069.4 2090.2 2343.1 2491.6 2538.8 2463.4 2472.7 2507.5 2510.6 2517.6 2037.5 2413.5 2507.6 2518.4 2526.2 11802.2 11893.0 11906.0 11908.9 11961.8 6591.4 6849.5 6861.7 6862.8 6863.9 3998.0 4362.0 4407.2 4418.7 4447.2 1267.9 1276.7 1305.8 1316.7 1319.4 14679.9 15285.8 15865.6 16797.6 16990.0 5022.7 5024.5 5490.7 5713.9 5724.9 11894.6 11998.3 12009.9 12022.3 12029.8 6248.8 6347.0 6350.6 6352.8 6367.6 5964.9 5985.4 6048.4 6068.8 6142.1 4306.0 4388.6 4391.3 4408.2 4410.4 1006.6 1199.6 1223.3 1282.0 1298.4 799.5 813.3 831.1 840.8 860.8 6050.9 6174.4 6217.7 6310.5 6467.6 532.9 599.5 619.7 621.7 632.3 4082.6 4182.7 4275.6 4353.7 4378.9 14761.3 15265.6 15279.4 15289.3 15307.2 14966.5 15105.4 15126.1 15166.7 15177.0 8182.6 8546.9 8758.7 8767.6 8793.4 6505.4 7066.9 7118.0 7191.6 7264.3 10935.6 11138.0 13397.7 13715.5 13898.9 13761.3 13942.0 13995.7 14093.1 14311.5 9325.5 9334.4 9396.8 9511.3 9512.9 8944.4 10652.3 10742.8 10788.5 10836.7 8625.4 8819.9 8850.9 8869.2 8890.0 8132.0 8509.8 9031.5 9103.5 9110.7 8270.0 8315.6 8393.7 8409.5 8438.2 5047.8 6167.7 6184.7 6203.3 6267.8 6095.0 6100.3 6277.1 6295.9 6425.6 05:05:14 INFO - PID 1662 | 05:05:14 INFO - PID 1662 | [#4] prototype.html Cycles:180 Average:5347.85 Median:6110.27 stddev:1738.39 (28.5%) stddev-sans-first:1702.28 05:05:14 INFO - PID 1662 | Values: 348.2 389.5 414.9 416.1 418.4 5268.3 5423.9 6122.9 6368.4 6410.5 5243.3 5924.9 6038.5 6158.6 6161.9 3884.6 4480.7 4508.5 4528.6 4556.1 4294.9 4479.9 4480.4 4480.4 4537.9 3691.0 4432.2 4450.4 4471.6 4476.2 4468.3 4472.3 4480.7 4503.6 4509.9 3137.6 3779.0 3801.9 3826.5 3867.8 4653.4 5965.3 5979.3 6010.3 6046.7 5362.3 5378.2 5383.3 5396.6 5404.5 5995.8 6517.9 6527.7 6591.9 6605.0 4356.6 4367.5 4373.9 4378.2 4387.9 6430.6 6638.9 6726.0 6946.4 7080.9 4369.5 4406.4 4411.3 4416.2 4436.8 3794.5 4466.2 4498.3 4503.9 4514.0 4254.5 4646.5 5297.6 5304.4 5352.5 5409.3 6316.0 6356.8 6399.7 6615.8 1405.1 1422.4 1430.5 1478.4 1586.9 936.1 963.3 1003.8 1008.2 1012.9 6261.3 6319.5 6338.3 6374.9 6377.5 6157.6 6312.0 6853.9 6866.5 6870.7 6197.0 6298.0 6308.5 6328.2 6346.7 3155.5 3201.5 3459.6 3503.5 3610.5 6069.4 6599.8 7032.0 7062.1 7107.9 6097.7 6983.1 7079.8 7100.1 7101.5 7026.9 7114.5 7239.3 7272.0 7276.3 5375.4 5996.6 6590.5 6840.8 7099.3 6638.2 6701.0 6725.0 6859.3 6905.0 7237.3 7246.4 7252.3 7256.6 7429.0 3909.8 4355.7 4373.8 4440.2 4459.7 6819.7 6921.2 6981.7 6985.8 6987.9 6141.7 6691.2 6713.7 6728.9 6751.6 6488.8 6634.8 6720.3 6722.2 6761.7 5446.0 5724.4 6609.4 6611.3 6612.4 6404.7 6627.6 6683.9 6745.0 6779.2 6599.2 6601.0 6607.4 6629.8 6651.9 05:05:14 INFO - PID 1662 | 05:05:14 INFO - PID 1662 | [#5] yui.html Cycles:180 Average:22196.62 Median:17333.28 stddev:32178.79 (185.6%) stddev-sans-first:32228.92 05:05:14 INFO - PID 1662 | Values: 790.9 831.4 836.8 863.7 873.9 14424.8 15001.2 16409.7 16870.3 16875.9 12425.5 13144.6 17300.7 17304.0 17335.7 983.6 984.9 991.5 991.5 995.1 990.7 1018.1 1018.5 1020.5 1021.2 981.6 1013.0 1049.4 1056.0 1058.6 784.9 1029.9 1045.7 1049.5 1051.2 777.8 781.1 786.6 787.1 790.0 13808.7 16863.6 17039.9 17081.4 17266.9 17182.7 17324.8 17330.9 17629.5 17671.3 13815.0 13931.9 13989.2 14092.7 14154.3 3495.7 3525.0 3525.8 3527.3 3531.9 104572.0 131791.0 132175.0 135913.8 136865.0 13403.7 13533.5 13543.6 13605.4 13763.2 25789.4 25918.9 26246.0 26257.7 26299.6 7585.1 7642.6 7683.3 7695.4 7725.6 3758.8 3823.3 3831.0 3831.8 3835.3 4390.6 4418.4 4441.5 4489.6 4497.9 872.9 890.4 890.6 893.2 897.2 648.4 658.3 665.3 669.6 681.3 11005.7 11658.6 11935.3 11947.2 12010.6 650.9 656.5 656.9 670.6 684.0 4653.7 4779.0 5404.8 5484.8 5564.7 106430.0 108418.5 111240.4 111666.0 114172.0 92863.5 94269.5 95000.0 95799.0 96134.5 87014.0 87471.0 88093.0 88272.6 92279.5 8571.8 10894.9 11071.1 11166.4 11188.5 42860.0 42916.8 43647.6 43837.6 44187.0 55736.9 56616.4 56768.4 57009.0 57149.0 13512.0 13618.4 13647.7 13791.8 14074.2 15103.2 15108.4 15275.5 15430.8 15452.5 16035.2 17084.3 17272.3 17373.4 17374.1 15689.0 15877.7 16180.6 16217.4 16484.5 15634.0 15873.8 16483.1 16631.1 16642.8 11421.3 11723.3 11963.7 12116.6 12232.9 12756.6 12840.5 12856.1 12908.9 12964.4 05:05:14 INFO - PID 1662 | -------- Summary: end -------- 05:05:14 INFO - PID 1662 | 05:05:15 INFO - TEST-INFO | 1662: exit 0 05:05:15 INFO - TEST-OK | dromaeo_css | took 1115785ms 05:05:15 INFO - TEST-START | kraken 05:05:15 INFO - operating with platform_type : mac_ 05:05:15 INFO - Initialising browser for kraken test... 05:05:15 INFO - TEST-INFO | started process 1788 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/tmpjU6QWV/profile http://localhost:49236/getInfo.html) 05:05:17 INFO - PID 1788 | 2017-05-04 05:05:17.940 plugin-container[1789:10408] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8343, name = 'com.apple.tsm.portname' 05:05:17 INFO - PID 1788 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:05:17 INFO - PID 1788 | 2017-05-04 05:05:17.941 plugin-container[1789:10408] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8253, name = 'com.apple.CFPasteboardClient' 05:05:17 INFO - PID 1788 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:05:17 INFO - PID 1788 | 2017-05-04 05:05:17.941 plugin-container[1789:10408] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:05:18 INFO - PID 1788 | __metrics Screen width/height:1600/1200 05:05:18 INFO - PID 1788 | colorDepth:24 05:05:18 INFO - PID 1788 | Browser inner width/height: 1024/691 05:05:18 INFO - PID 1788 | __metrics 05:05:19 INFO - TEST-INFO | 1788: exit 0 05:05:19 INFO - Browser initialized. 05:05:19 INFO - Running cycle 1/1 for kraken test... 05:05:19 INFO - TEST-INFO | started process 1790 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/tmpjU6QWV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:05:21 INFO - PID 1790 | 2017-05-04 05:05:21.667 plugin-container[1791:10533] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x863f, name = 'com.apple.tsm.portname' 05:05:21 INFO - PID 1790 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:05:21 INFO - PID 1790 | 2017-05-04 05:05:21.668 plugin-container[1791:10533] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x3f0f, name = 'com.apple.CFPasteboardClient' 05:05:21 INFO - PID 1790 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:05:21 INFO - PID 1790 | 2017-05-04 05:05:21.668 plugin-container[1791:10533] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:05:22 INFO - PID 1790 | 2017-05-04 05:05:22.143 plugin-container[1792:10572] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x822b, name = 'com.apple.tsm.portname' 05:05:22 INFO - PID 1790 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:05:22 INFO - PID 1790 | 2017-05-04 05:05:22.144 plugin-container[1792:10572] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4217, name = 'com.apple.CFPasteboardClient' 05:05:22 INFO - PID 1790 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:05:22 INFO - PID 1790 | 2017-05-04 05:05:22.144 plugin-container[1792:10572] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:05:31 INFO - PID 1790 | RSS: Main: 250445824 05:05:31 INFO - PID 1790 | 05:05:34 INFO - PID 1790 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection) 05:05:35 INFO - PID 1790 | RSS: Main: 258621440 05:05:35 INFO - PID 1790 | 05:05:37 INFO - PID 1790 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-dft) 05:05:38 INFO - PID 1790 | RSS: Main: 265035776 05:05:38 INFO - PID 1790 | 05:05:41 INFO - PID 1790 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-fft) 05:05:42 INFO - PID 1790 | RSS: Main: 259981312 05:05:42 INFO - PID 1790 | 05:05:44 INFO - PID 1790 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator) 05:05:45 INFO - PID 1790 | RSS: Main: 261107712 05:05:45 INFO - PID 1790 | 05:05:47 INFO - PID 1790 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:05:47 INFO - PID 1790 | RSS: Main: 262934528 05:05:47 INFO - PID 1790 | 05:05:50 INFO - PID 1790 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom) 05:05:51 INFO - PID 1790 | RSS: Main: 268722176 05:05:51 INFO - PID 1790 | 05:05:53 INFO - PID 1790 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate) 05:05:54 INFO - PID 1790 | RSS: Main: 270147584 05:05:54 INFO - PID 1790 | 05:05:57 INFO - PID 1790 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial) 05:05:58 INFO - PID 1790 | RSS: Main: 269467648 05:05:58 INFO - PID 1790 | 05:05:59 INFO - PID 1790 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:06:00 INFO - PID 1790 | RSS: Main: 268861440 05:06:00 INFO - PID 1790 | 05:06:02 INFO - PID 1790 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:06:02 INFO - PID 1790 | RSS: Main: 268865536 05:06:02 INFO - PID 1790 | 05:06:05 INFO - PID 1790 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:06:05 INFO - PID 1790 | RSS: Main: 268455936 05:06:05 INFO - PID 1790 | 05:06:08 INFO - PID 1790 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:06:09 INFO - PID 1790 | RSS: Main: 268517376 05:06:09 INFO - PID 1790 | 05:06:12 INFO - PID 1790 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:06:13 INFO - PID 1790 | RSS: Main: 268767232 05:06:13 INFO - PID 1790 | 05:06:15 INFO - PID 1790 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49236/tests/kraken/driver.html?testName=ai-astar) 05:06:15 INFO - PID 1790 | RSS: Main: 270376960 05:06:15 INFO - PID 1790 | 05:06:15 INFO - PID 1790 | __start_tp_report 05:06:15 INFO - PID 1790 | _x_x_mozilla_page_load 05:06:15 INFO - PID 1790 | _x_x_mozilla_page_load_details 05:06:15 INFO - PID 1790 | |i|pagename|runs| 05:06:15 INFO - PID 1790 | |0;ai-astar;82;96;143;169;167;114;114;113;114;136 05:06:15 INFO - PID 1790 | |1;audio-beat-detection;147;134;144;142;133;106;104;127;136;145 05:06:15 INFO - PID 1790 | |2;audio-dft;197;198;201;222;214;239;217;199;201;202 05:06:15 INFO - PID 1790 | |3;audio-fft;83;56;58;83;60;67;74;90;77;83 05:06:15 INFO - PID 1790 | |4;audio-oscillator;86;71;112;105;82;70;85;71;73;89 05:06:15 INFO - PID 1790 | |5;imaging-gaussian-blur;89;90;88;89;90;89;90;103;89;88 05:06:15 INFO - PID 1790 | |6;imaging-darkroom;96;99;96;96;97;96;96;96;97;96 05:06:15 INFO - PID 1790 | |7;imaging-desaturate;91;110;117;75;133;142;115;95;95;92 05:06:15 INFO - PID 1790 | |8;json-parse-financial;51;50;49;50;51;65;73;64;44;50 05:06:15 INFO - PID 1790 | |9;json-stringify-tinderbox;56;54;65;69;64;62;57;56;56;55 05:06:15 INFO - PID 1790 | |10;stanford-crypto-aes;84;82;92;109;76;101;110;108;105;82 05:06:15 INFO - PID 1790 | |11;stanford-crypto-ccm;146;139;123;146;152;126;130;143;205;173 05:06:15 INFO - PID 1790 | |12;stanford-crypto-pbkdf2;178;226;174;222;232;183;188;184;184;186 05:06:15 INFO - PID 1790 | |13;stanford-crypto-sha256-iterative;67;69;69;68;67;67;66;66;65;79 05:06:15 INFO - PID 1790 | __end_tp_report 05:06:15 INFO - PID 1790 | __start_cc_report 05:06:15 INFO - PID 1790 | _x_x_mozilla_cycle_collect,986 05:06:15 INFO - PID 1790 | __end_cc_report 05:06:15 INFO - PID 1790 | __startTimestamp1493899575271__endTimestamp 05:06:15 INFO - PID 1790 | 05:06:15 INFO - PID 1790 | ------- Summary: start ------- 05:06:15 INFO - PID 1790 | Number of tests: 14 05:06:15 INFO - PID 1790 | 05:06:15 INFO - PID 1790 | [#0] ai-astar Cycles:10 Average:124.80 Median:155.00 stddev:28.56 (18.4%) stddev-sans-first:25.75 05:06:15 INFO - PID 1790 | Values: 82.0 96.0 143.0 169.0 167.0 114.0 114.0 113.0 114.0 136.0 05:06:15 INFO - PID 1790 | 05:06:15 INFO - PID 1790 | [#1] audio-beat-detection Cycles:10 Average:131.80 Median:139.00 stddev:15.43 (11.1%) stddev-sans-first:15.36 05:06:15 INFO - PID 1790 | Values: 147.0 134.0 144.0 142.0 133.0 106.0 104.0 127.0 136.0 145.0 05:06:15 INFO - PID 1790 | 05:06:15 INFO - PID 1790 | [#2] audio-dft Cycles:10 Average:209.00 Median:208.00 stddev:13.74 (6.6%) stddev-sans-first:13.87 05:06:15 INFO - PID 1790 | Values: 197.0 198.0 201.0 222.0 214.0 239.0 217.0 199.0 201.0 202.0 05:06:15 INFO - PID 1790 | 05:06:15 INFO - PID 1790 | [#3] audio-fft Cycles:10 Average:73.10 Median:80.00 stddev:12.13 (15.2%) stddev-sans-first:12.33 05:06:15 INFO - PID 1790 | Values: 83.0 56.0 58.0 83.0 60.0 67.0 74.0 90.0 77.0 83.0 05:06:15 INFO - PID 1790 | 05:06:15 INFO - PID 1790 | [#4] audio-oscillator Cycles:10 Average:84.40 Median:77.50 stddev:14.58 (18.8%) stddev-sans-first:15.45 05:06:15 INFO - PID 1790 | Values: 86.0 71.0 112.0 105.0 82.0 70.0 85.0 71.0 73.0 89.0 05:06:15 INFO - PID 1790 | 05:06:15 INFO - PID 1790 | [#5] imaging-gaussian-blur Cycles:10 Average:90.50 Median:89.00 stddev:4.45 (5.0%) stddev-sans-first:4.69 05:06:15 INFO - PID 1790 | Values: 89.0 90.0 88.0 89.0 90.0 89.0 90.0 103.0 89.0 88.0 05:06:15 INFO - PID 1790 | 05:06:15 INFO - PID 1790 | [#6] imaging-darkroom Cycles:10 Average:96.50 Median:96.00 stddev:0.97 (1.0%) stddev-sans-first:1.01 05:06:15 INFO - PID 1790 | Values: 96.0 99.0 96.0 96.0 97.0 96.0 96.0 96.0 97.0 96.0 05:06:15 INFO - PID 1790 | 05:06:15 INFO - PID 1790 | [#7] imaging-desaturate Cycles:10 Average:106.50 Median:83.00 stddev:20.72 (25.0%) stddev-sans-first:21.21 05:06:15 INFO - PID 1790 | Values: 91.0 110.0 117.0 75.0 133.0 142.0 115.0 95.0 95.0 92.0 05:06:15 INFO - PID 1790 | 05:06:15 INFO - PID 1790 | [#8] json-parse-financial Cycles:10 Average:54.70 Median:51.00 stddev:9.24 (18.1%) stddev-sans-first:9.70 05:06:15 INFO - PID 1790 | Values: 51.0 50.0 49.0 50.0 51.0 65.0 73.0 64.0 44.0 50.0 05:06:15 INFO - PID 1790 | 05:06:15 INFO - PID 1790 | [#9] json-stringify-tinderbox Cycles:10 Average:59.40 Median:59.50 stddev:5.17 (8.7%) stddev-sans-first:5.33 05:06:15 INFO - PID 1790 | Values: 56.0 54.0 65.0 69.0 64.0 62.0 57.0 56.0 56.0 55.0 05:06:15 INFO - PID 1790 | 05:06:15 INFO - PID 1790 | [#10] stanford-crypto-aes Cycles:10 Average:94.90 Median:79.00 stddev:13.14 (16.6%) stddev-sans-first:13.34 05:06:15 INFO - PID 1790 | Values: 84.0 82.0 92.0 109.0 76.0 101.0 110.0 108.0 105.0 82.0 05:06:15 INFO - PID 1790 | 05:06:15 INFO - PID 1790 | [#11] stanford-crypto-ccm Cycles:10 Average:148.30 Median:146.00 stddev:24.58 (16.8%) stddev-sans-first:26.05 05:06:15 INFO - PID 1790 | Values: 146.0 139.0 123.0 146.0 152.0 126.0 130.0 143.0 205.0 173.0 05:06:15 INFO - PID 1790 | 05:06:15 INFO - PID 1790 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:195.70 Median:187.00 stddev:21.86 (11.7%) stddev-sans-first:22.23 05:06:15 INFO - PID 1790 | Values: 178.0 226.0 174.0 222.0 232.0 183.0 188.0 184.0 184.0 186.0 05:06:15 INFO - PID 1790 | 05:06:15 INFO - PID 1790 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:67.50 stddev:3.97 (5.9%) stddev-sans-first:4.19 05:06:15 INFO - PID 1790 | Values: 67.0 69.0 69.0 68.0 67.0 67.0 66.0 66.0 65.0 79.0 05:06:15 INFO - PID 1790 | -------- Summary: end -------- 05:06:15 INFO - PID 1790 | 05:06:16 INFO - TEST-INFO | 1790: exit 0 05:06:16 INFO - TEST-OK | kraken | took 61157ms 05:06:16 INFO - SUITE-END | took 1176s 05:06:16 INFO - Completed test suite (00:19:37) 05:06:16 INFO - javascript benchmark 05:06:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7870.959327483617, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2996.760259179266, 3315.6187038490575, 3562.127278816692, 3611.2596917631886, 3624.6737793598577, 4380.934285985712, 4670.486246512885, 5585.050541407955, 5996.6402015879075, 6243.0, 6125.845966769323, 6144.187464697914, 6200.10098535712, 6201.596896201755, 6237.03325984472, 4252.957470425287, 5317.308749862532, 5369.0, 5373.623846330758, 5439.619226654136, 5438.8912221755545, 5464.153056276284, 5473.726313684319, 5497.175423686439, 5510.5316048135755, 5344.893102137936, 5371.623986320959, 5421.701806400646, 5456.890862182734, 5512.145617429305, 5455.0453670607885, 5477.0, 5497.8075767348355, 5498.0, 5515.806946756885, 5335.7865685372535, 5368.677879327214, 5379.757910894019, 5411.107167317388, 5419.3225846769155, 6061.727222275008, 6227.782027629011, 6239.376062393724, 6246.937530624681, 6264.9686751566405, 6370.936290637081, 6454.515911306624, 6592.637404942774, 6649.80050598478, 6651.800445986628, 6762.120924279861, 6768.052472653832, 6774.983752437124, 6775.525713200078, 6784.966075169642, 6243.7814676486105, 6250.093736408196, 6276.121343011982, 6316.6841657917375, 6323.52573556985, 6304.716287767062, 6669.7332106715185, 6740.325967403319, 6896.069030680794, 6946.027556142144, 6343.3339499351905, 6396.584222025554, 6491.902621460682, 6506.772262970773, 6600.867982640416, 6603.504737144734, 6699.330066993359, 6712.228093769181, 6730.293319201512, 6748.358905903931, 6624.27133015368, 6627.701753421107, 6647.202335719745, 6654.334566543307, 6670.4997125215805, 6440.903386449207, 6486.935130648728, 6559.770408035696, 6639.900401493981, 6673.632950187786, 5275.709835959059, 5279.9208011879855, 5290.259363689087, 5309.017831701148, 5333.679979201261, 4548.340490628841, 4665.4634717007975, 4666.883327916829, 4673.322368256584, 4685.4143232095985, 6242.687865606701, 6269.185005949197, 6329.715162817684, 6341.175647165839, 6360.936390636034, 6691.5650482718465, 6733.192016957996, 6733.494987875831, 6757.628330441775, 6761.391474767294, 6340.714667839959, 6354.777582784673, 6364.681765911779, 6373.012183111625, 6374.075759014917, 5748.540116790647, 5825.0679891217205, 5894.32215295238, 5901.232839730894, 5931.6441013539325, 5147.305113809737, 6765.830854228684, 6787.728490860311, 6904.275051119761, 6929.757458488929, 5603.915941260802, 5621.971890140523, 6705.295943926013, 6715.294894036056, 6781.864362712817, 6845.931540684529, 6892.793216203522, 6905.585664859924, 6954.3393377629045, 6967.7212911482975, 5786.07422812348, 6120.571559990758, 6280.905786413116, 6486.772962946275, 6617.0, 5875.853103672443, 6322.0, 6632.966835165793, 6711.597304161766, 6731.024001519654, 5347.545458636059, 6091.238595175603, 6199.969000154971, 6442.742290308335, 6449.806505804833, 5554.944450555443, 6496.9025464617125, 6525.0, 6531.2489063756375, 6568.540202185801, 6238.220222472191, 6419.261784894797, 6444.9355506444335, 6475.579087359307, 6533.509986750918, 5453.509184173444, 6356.4279214870885, 6446.258680251831, 6455.289918108911, 6555.475561955128, 5094.5160209780015, 6377.8724425512155, 6437.839054023687, 6445.226572811105, 6448.871022579616], "value": 6000.979579369511, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [730.7734602273296, 734.342763226912, 808.4906508899394, 1142.8514293141895, 1274.1208566089404, 36606.26787464252, 37844.24311513768, 37926.62073379269, 37982.43026354603, 38025.80987095061, 29354.85322573384, 38125.0, 38153.0, 38171.0, 38214.80892595533, 7775.339096176817, 7957.403194760387, 8348.332133429341, 8583.442076265053, 8623.482591044558, 8529.10444403338, 8567.143285671445, 8631.136886311382, 8633.13668633138, 8633.13668633138, 8595.312375010015, 8613.138686131399, 8676.045634980179, 8683.261922736543, 8684.218420342168, 8616.526091064989, 8631.0, 8633.52515611638, 8639.35204859638, 8654.783630409227, 8343.707970221074, 8360.874586881202, 8424.747257582283, 8440.57797110142, 8447.070822209553, 37332.880013599366, 37487.812560937295, 37773.244535109145, 37785.0, 37886.24227515462, 3484.494748261488, 3603.387424137903, 3610.097475631092, 3611.765235259726, 3616.8372423240753, 30627.23431914198, 30827.537586936214, 30875.536866947015, 30906.0, 31033.0, 3123.6095488063993, 3131.123285480069, 3163.3234385775577, 3172.460681684096, 3180.6024246969127, 252496.68758281006, 280869.0, 281092.0, 325128.7435628209, 326718.0, 38684.61315386866, 47270.05459890783, 47514.52485475101, 47692.76153619279, 47696.5230347699, 50010.0, 50026.74933126701, 56480.0, 56574.71712641411, 56961.145582816294, 14623.488177913934, 14648.707025859423, 14732.77900831467, 14762.966592338647, 14785.89105817068, 11568.652940411801, 11699.824502632468, 11770.76458470843, 11776.11679124069, 11790.292582445081, 14313.64215894611, 14317.498887538886, 14366.35351409189, 14415.927920360331, 14447.638809029859, 5100.897982040338, 6130.478909292671, 6144.38556144382, 6181.690915454209, 6195.070739389128, 912.9090736569868, 947.7630592351912, 982.219135787051, 1051.6792378324685, 1081.3079629037422, 19311.0, 20519.17923283052, 22763.658545121838, 25189.87405062963, 25291.241262762145, 1138.5218208352512, 1150.5340337163461, 1171.3147808532103, 1176.623480486236, 1188.441432526711, 11107.44462776874, 12348.814767778491, 12760.361981900867, 12950.352482375843, 13082.607521774362, 279931.0, 348437.0, 349721.0, 350324.0, 350584.0, 54111.72944135254, 54494.45505544973, 54596.72701636466, 54600.180997285075, 54870.72564637231, 1356.3218390804598, 1511.6749898771816, 1536.0860288128545, 1567.851054149854, 1572.2688949638243, 21882.781172188075, 24338.391540211636, 24402.389940251636, 24470.877645611657, 24577.63133553034, 37858.0, 38014.239715206095, 38067.61932380641, 38091.85724428271, 38336.0, 280885.0, 281898.59050704614, 282039.0, 282905.5854720713, 283271.0, 34823.825880870434, 35633.0, 35890.0, 36624.81687591545, 36681.44977825388, 45124.0, 45782.08435831198, 46546.76726616345, 46583.30125048195, 46808.0, 29373.412531749673, 31071.68928310688, 31154.0, 31572.526412103376, 31954.40227988545, 25649.487010260065, 28101.57847632328, 30885.918992836043, 31791.682083178872, 31936.52095218527, 37334.43998339973, 37744.433833493065, 37972.0, 38104.80947595244, 38316.42525362066, 23566.057357706184, 29494.852525737235, 30589.54115688311, 31721.0, 31840.52239216367, 23621.881890590437, 24304.0, 25049.761295439832, 25162.0, 25176.49647007013], "value": 17665.553092557097, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [431.6093934988836, 439.07355479937326, 441.9658000279348, 453.53512649534224, 458.63996762541393, 17394.652106957852, 17870.463886083406, 19111.42665720027, 20821.0, 21715.0, 22206.444838879037, 23430.41423964402, 23437.296881093593, 23488.647670284958, 23598.410039749015, 6107.541934354919, 6251.562390632657, 6253.499720022387, 6265.530085243602, 6299.937000630004, 4890.975545122269, 5393.1370980643105, 5986.700664966756, 6179.7837075702355, 6187.721552530124, 4890.951090489085, 5864.530837532987, 6163.044728067157, 6164.383561643845, 6168.290646575656, 5953.58324917256, 6094.847628809271, 6108.602940808833, 6150.784722534712, 6156.476699480527, 4295.806688699016, 5286.207068939651, 5463.863403414906, 5471.069918113891, 5477.04151773438, 28179.0, 28544.571831422545, 28701.0, 29020.709792902013, 29171.124866254046, 2095.916163353464, 2156.482444213393, 2236.228501167111, 2246.4945387287894, 2249.3701763506083, 17569.736453953203, 17924.820751792446, 18092.90953545237, 18122.818771812246, 18334.0, 2025.159558783118, 2130.9573808523896, 2173.7608863025052, 2175.216921908112, 2183.8689678619335, 155290.11774705723, 164114.17942910327, 169375.0, 173385.0, 176102.0, 12751.553695620609, 12817.807732884014, 13071.803922941164, 13106.80339794904, 13209.0, 16849.41027064047, 16875.409360672318, 16886.91556542234, 16892.40876569314, 16913.661726765396, 8797.38418310712, 9119.452832829918, 9143.268538517035, 9308.30187735909, 9329.393589416666, 8758.080401557872, 8779.165979231962, 8818.0, 8981.05698901619, 8984.371094023487, 7889.566073865878, 8037.276645101969, 8037.638306276232, 8067.798305042421, 8106.351491880635, 2220.4448887778058, 2229.8885055747146, 2234.1510226113974, 2246.449619843149, 2406.205952035824, 963.9469829159324, 980.6763767956558, 986.4574484033752, 1007.6422869881234, 1033.5555711044324, 21168.78831211699, 21716.348509544423, 21848.563028739653, 21884.343469695934, 21913.452163695718, 901.3915606965272, 982.9017098290113, 1015.9224386130381, 1036.7356324137297, 1052.6684094510206, 10559.049685528185, 11268.816774238587, 11290.54837806495, 11301.886981130248, 11326.546938122383, 529009.0, 534909.0, 535187.0, 567133.0, 567534.0, 128643.0, 142701.5729842709, 143165.28417358056, 145743.0, 149576.51270461903, 1211.8364020857248, 1241.422738426636, 1257.094891677972, 1257.25821765159, 1264.8166015927823, 18585.34951276699, 18838.0, 22116.778832211472, 22950.655740164246, 23475.41311467227, 59212.70393648177, 59312.703436482545, 59724.50688732816, 59780.40219597922, 60373.0, 82901.0, 83718.0, 83924.74112888434, 85166.0, 85477.57261213654, 8940.061293564342, 9172.587233574372, 9256.768580785265, 9261.44431334122, 9268.490233037248, 14121.435142594592, 14170.220637865017, 14536.273186340852, 14684.118952862862, 14736.852631473548, 11857.16999810005, 11989.0, 12040.819387709367, 12082.939585302018, 12095.246189302326, 11336.0, 11412.600558980395, 11468.197226194086, 11615.883841161818, 11799.941000294944, 10909.690837099599, 11352.829707554229, 11948.46231919583, 12173.939130304292, 12220.633380998584, 7492.475526713078, 8577.65689372443, 9046.683366082156, 9169.495677737521, 9243.96632740796, 9989.650362237287, 10688.251822372671, 11549.82675259855, 11865.822012669989, 12136.635900922987], "value": 10634.76920091325, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1414.497853262092, 1445.0968144909425, 1451.8838492920568, 1457.8542145785423, 1459.7883756482122, 9247.768805779859, 9930.851037234448, 11425.371604561746, 11930.284182949019, 11957.342346170968, 11810.468528916197, 11982.340971246578, 12019.639410817668, 12023.879761202385, 12070.155089143764, 2526.8862901169446, 2564.2050964201158, 2565.6921169459692, 2566.3199252198183, 2575.5364034473787, 2480.8139389545854, 2523.5962246040544, 2524.406764410362, 2534.797216222707, 2538.1370334086405, 2069.379186244121, 2090.1848279171136, 2343.1096183450263, 2491.6262560615874, 2538.7968962482955, 2463.4334103156284, 2472.7032756069207, 2507.523570521595, 2510.648509208694, 2517.622356646499, 2037.521182522106, 2413.505231427571, 2507.6238564215514, 2518.420763224469, 2526.178991827663, 11802.232854864405, 11893.04855611549, 11906.0, 11908.880911190863, 11961.820572691417, 6591.373819487189, 6849.520533562652, 6861.730579842745, 6862.794116176523, 6863.862722745517, 3997.960020399817, 4361.956380436219, 4407.206702793496, 4418.712783669083, 4447.221736196153, 1267.854196767365, 1276.7318863038772, 1305.8106574546637, 1316.6642506160963, 1319.3996731487246, 14679.926600367036, 15285.847141528664, 15865.603359916095, 16797.58006049846, 16990.0, 5022.698638081727, 5024.49755024502, 5490.725463726798, 5713.914291285634, 5724.914126288109, 11894.643160705193, 11998.280103193661, 12009.939950300193, 12022.338771367658, 12029.819552706716, 6248.843778905563, 6347.047942808524, 6350.587211831216, 6352.8411789704705, 6367.554271200971, 5964.85087872798, 5985.401459854067, 6048.425399587032, 6068.787592434243, 6142.140100385949, 4306.009617787864, 4388.561143885586, 4391.253486907233, 4408.228560001987, 4410.448693913261, 1006.5671761142779, 1199.5861427807392, 1223.253815172744, 1281.9807702884464, 1298.4222021200665, 799.4923223752959, 813.2721214512977, 831.1273163178638, 840.7898025493627, 860.767592749954, 6050.878982420327, 6174.38256174388, 6217.689115544295, 6310.463610593151, 6467.611943283418, 532.9227262046982, 599.5024129972113, 619.6986328709763, 621.6860485454816, 632.3360471504993, 4082.6121518455698, 4182.665386769051, 4275.551067137968, 4353.695241333076, 4378.912421751547, 14761.261936903113, 15265.618359540878, 15279.38882444712, 15289.311980960661, 15307.234638268043, 14966.476173333882, 15105.39578416851, 15126.092434453967, 15166.696666066617, 15177.0, 8182.631781569844, 8546.871796923051, 8758.693445729496, 8767.649294028168, 8793.428427152214, 6505.447037001908, 7066.858662826612, 7118.039064726196, 7191.604461754654, 7264.309890560388, 10935.56257749681, 11138.0, 13397.665058373228, 13715.519956801463, 13898.930505347409, 13761.31193440344, 13941.95435342333, 13995.650108747363, 14093.083949543246, 14311.499097531536, 9325.533723313943, 9334.439933604006, 9396.76508087276, 9511.334206605748, 9512.90487095148, 8944.37389382737, 10652.254342195973, 10742.785144297226, 10788.460576971276, 10836.729081773019, 8625.353098517511, 8819.867701984347, 8850.867236991322, 8869.157430044135, 8889.955550222208, 8131.9593402032615, 8509.829803403773, 9031.503267320099, 9103.453792772454, 9110.726678199664, 8270.0, 8315.584220789058, 8393.748187554384, 8409.495430274203, 8438.198371154731, 5047.848564543069, 6167.722452489738, 6184.6598437086395, 6203.2556093269095, 6267.809116267895, 6095.0, 6100.328963814066, 6277.085488925922, 6295.905561416674, 6425.614463132227], "value": 5304.477640097129, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.2286734882236, 389.45281878960054, 414.9128682976575, 416.0908415112979, 418.4079527468634, 5268.341457317835, 5423.945760542393, 6122.87754244916, 6368.426841584268, 6410.455111315532, 5243.2659427680155, 5924.940750592504, 6038.4867286280605, 6158.59969102008, 6161.938380616204, 3884.553276373225, 4480.7087539310005, 4508.549145085498, 4528.592426681598, 4556.134334476439, 4294.871153865389, 4479.932801007987, 4480.364666896576, 4480.395146655193, 4537.931931021021, 3691.0, 4432.20220360335, 4450.399196108517, 4471.630036080883, 4476.239039363316, 4468.329750537429, 4472.284434490466, 4480.6639502037315, 4503.5946764791, 4509.932351014738, 3137.592113025315, 3778.9811050944845, 3801.9279492676555, 3826.540815102178, 3867.7679339239735, 4653.441587009581, 5965.343812180657, 5979.312379076375, 6010.338862725097, 6046.667433291167, 5362.276092727471, 5378.2470454136455, 5383.2732581101445, 5396.568274538027, 5404.486573775524, 5995.760169593211, 6517.93482065178, 6527.738890444377, 6591.901121483182, 6605.042268871035, 4356.564343565618, 4367.54140815213, 4373.934390984138, 4378.16814805186, 4387.868363949086, 6430.582012169194, 6638.892219158386, 6726.022743170019, 6946.444284457231, 7080.92919070813, 4369.519352871182, 4406.449193850769, 4411.338299255138, 4416.1609294233995, 4436.844710435119, 3794.5256842894637, 4466.218411777926, 4498.3010193884065, 4503.887402814956, 4514.029483660963, 4254.468191476066, 4646.465656449484, 5297.602679799031, 5304.416514183436, 5352.484332363782, 5409.269748583891, 6316.021016742412, 6356.809295721136, 6399.680015999182, 6615.750644780797, 1405.1358414575168, 1422.4168091082606, 1430.499325236159, 1478.4160256698758, 1586.912719800399, 936.0592604432638, 963.3449254507002, 1003.8066823989606, 1008.1783346572666, 1012.9189664826796, 6261.3407447026575, 6319.494440444753, 6338.271098823694, 6374.904376434357, 6377.4579160771855, 6157.630542167395, 6311.968440157862, 6853.897191542131, 6866.485013623998, 6870.656467176721, 6197.0, 6298.0, 6308.52686048539, 6328.240611126695, 6346.7476790550445, 3155.49512078071, 3201.519772034167, 3459.6367381425093, 3503.5095086687884, 3610.494530765695, 6069.3627169147485, 6599.8350041248395, 7032.015517827406, 7062.081929349151, 7107.92892071083, 6097.664628445478, 6983.057287266256, 7079.752208672775, 7100.112485939258, 7101.538400003983, 7026.92973070273, 7114.466415018895, 7239.276072392824, 7272.0, 7276.344134391015, 5375.35495740498, 5996.580239383201, 6590.50571207171, 6840.794776156723, 7099.254578269208, 6638.236602790741, 6700.961350990604, 6725.0, 6859.348361905611, 6905.0, 7237.276272372721, 7246.4202863771825, 7252.311030452099, 7256.637168141678, 7429.034225550644, 3909.804509774443, 4355.715064056048, 4373.781310934377, 4440.245158323029, 4459.687821852439, 6819.727210911508, 6921.169459664872, 6981.650917454209, 6985.79042628722, 6987.895181572382, 6141.662208578571, 6691.197056353269, 6713.697883595152, 6728.880402673338, 6751.615918736746, 6488.837779055372, 6634.800955971328, 6720.260771315054, 6722.159730033746, 6761.695723692347, 5446.0122055450265, 5724.3703192647945, 6609.438197753245, 6611.322414422167, 6612.437942774918, 6404.743810247538, 6627.635480048643, 6683.8663226734225, 6745.0, 6779.220389655253, 6599.175103112111, 6601.0, 6607.372299631527, 6629.834254143492, 6651.866962660622], "value": 4797.869798555701, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [790.8774140008301, 831.4013909984809, 836.8033512124649, 863.7499314286284, 873.8596132047677, 14424.783628245585, 15001.249937503137, 16409.671806563878, 16870.325186992523, 16875.915620421896, 12425.502979880817, 13144.60566183016, 17300.653986920253, 17303.96176229427, 17335.653286934255, 983.6409710455704, 984.8867380251273, 991.459654488302, 991.4893829677721, 995.1193194023269, 990.7374545745383, 1018.0837246478192, 1018.5365658625345, 1020.5305559442666, 1021.2442792333694, 981.6024510073431, 1013.0123129948315, 1049.4437947887632, 1056.0495554001384, 1058.6241884131139, 784.8901153838467, 1029.8970102989679, 1045.7385653586603, 1049.5014867937707, 1051.2431049644244, 777.7744454108301, 781.1329424338979, 786.5595266650694, 787.0712559180165, 790.0440467034895, 13808.654783630389, 16863.57841053971, 17039.914800426042, 17081.402150924783, 17266.91366543172, 17182.74225886613, 17324.826751732446, 17330.913345433193, 17629.471115866418, 17671.293148274053, 13815.0, 13931.860681393158, 13989.160650361011, 14092.718145637133, 14154.292285385793, 3495.667911548399, 3525.0, 3525.7884526928465, 3527.276908233806, 3531.9293614127832, 104572.0, 131791.0, 132175.0, 135913.82835485943, 136865.0, 13403.664908377368, 13533.45866165362, 13543.59369218925, 13605.387757550934, 13763.243021633907, 25789.3552661185, 25918.870405647853, 26246.0, 26257.737422625913, 26299.605505917425, 7585.127710313274, 7642.579658118746, 7683.308502234826, 7695.384369250559, 7725.575093369918, 3758.8496460141837, 3823.292690852146, 3830.9808450957566, 3831.750936189139, 3835.328817456934, 4390.582894625006, 4418.381426600278, 4441.533638967927, 4489.595936365743, 4497.910041799146, 872.9476231426135, 890.412327863607, 890.6259371064168, 893.1559676106148, 897.1880448194395, 648.3905129178557, 658.3120638932327, 665.3180489997694, 669.6183175589964, 681.2608319972885, 11005.669829904955, 11658.607109028231, 11935.343556104497, 11947.223430476992, 12010.63968080959, 650.8795872763554, 656.4780999105723, 656.8883289840738, 670.6009924095156, 683.9760608378782, 4653.744044077608, 4778.972520907952, 5404.83785486436, 5484.808031718871, 5564.693941833238, 106430.0, 108418.45790770996, 111240.4437977821, 111666.0, 114172.0, 92863.49510876587, 94269.5286523563, 94999.97500237466, 95799.0420095804, 96134.51932740431, 87014.0, 87471.0, 88093.0, 88272.5586372064, 92279.53860230657, 8571.785705357415, 10894.945525272324, 11071.05895998817, 11166.44167791591, 11188.496517656562, 42860.0, 42916.78541607272, 43647.56352436435, 43837.56162438462, 44187.0, 55736.885262295335, 56616.43383566276, 56768.432315677965, 57009.0, 57149.0, 13512.0, 13618.38717257706, 13647.727045458836, 13791.793123102962, 14074.225917574631, 15103.244837758288, 15108.39566417331, 15275.465358712392, 15430.84569154339, 15452.5364239073, 16035.198240088183, 17084.316627334767, 17272.309107635552, 17373.391931282345, 17374.131293435024, 15689.0, 15877.737627023917, 16180.621824304182, 16217.432389866299, 16484.505464835594, 15634.0, 15873.761893571836, 16483.093429861474, 16631.085290308663, 16642.833571664127, 11421.31472111676, 11723.296602203895, 11963.700907477383, 12116.575919842764, 12232.938835305766, 12756.61730148097, 12840.486380545048, 12856.100072995174, 12908.935455322664, 12964.416601253155], "value": 8286.40098916912, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1537.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 96.0, 143.0, 169.0, 167.0, 114.0, 114.0, 113.0, 114.0, 136.0], "value": 124.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 134.0, 144.0, 142.0, 133.0, 106.0, 104.0, 127.0, 136.0, 145.0], "value": 131.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 198.0, 201.0, 222.0, 214.0, 239.0, 217.0, 199.0, 201.0, 202.0], "value": 209.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 56.0, 58.0, 83.0, 60.0, 67.0, 74.0, 90.0, 77.0, 83.0], "value": 73.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 71.0, 112.0, 105.0, 82.0, 70.0, 85.0, 71.0, 73.0, 89.0], "value": 84.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 90.0, 88.0, 89.0, 90.0, 89.0, 90.0, 103.0, 89.0, 88.0], "value": 90.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 99.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 97.0, 96.0], "value": 96.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 110.0, 117.0, 75.0, 133.0, 142.0, 115.0, 95.0, 95.0, 92.0], "value": 106.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 50.0, 49.0, 50.0, 51.0, 65.0, 73.0, 64.0, 44.0, 50.0], "value": 54.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 65.0, 69.0, 64.0, 62.0, 57.0, 56.0, 56.0, 55.0], "value": 59.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 92.0, 109.0, 76.0, 101.0, 110.0, 108.0, 105.0, 82.0], "value": 94.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 139.0, 123.0, 146.0, 152.0, 126.0, 130.0, 143.0, 205.0, 173.0], "value": 148.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 226.0, 174.0, 222.0, 232.0, 183.0, 188.0, 184.0, 184.0, 186.0], "value": 195.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 69.0, 68.0, 67.0, 67.0, 66.0, 66.0, 65.0, 79.0], "value": 68.3, "unit": "score"}]}]} 05:06:17 INFO - Return code: 0 05:06:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:06:17 INFO - # TBPL SUCCESS # 05:06:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:06:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:06:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:06:17 INFO - 2017-05-04 05:06:17.110 screenresolution[1803:10954] starting screenresolution argv=screenresolution get 05:06:17 INFO - 2017-05-04 05:06:17.112 screenresolution[1803:10954] Display 0: 1600x1200x32@60 05:06:17 INFO - 2017-05-04 05:06:17.118 screenresolution[1804:10957] starting screenresolution argv=screenresolution list 05:06:17 INFO - Available Modes on Display 0 05:06:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:06:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:06:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:06:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:06:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:06:17 INFO - Intel Iris: 05:06:17 INFO - Chipset Model: Intel Iris 05:06:17 INFO - Type: GPU 05:06:17 INFO - Bus: Built-In 05:06:17 INFO - VRAM (Dynamic, Max): 1536 MB 05:06:17 INFO - Vendor: Intel (0x8086) 05:06:17 INFO - Device ID: 0x0a2e 05:06:17 INFO - Revision ID: 0x0009 05:06:17 INFO - Displays: 05:06:17 INFO - Display: 05:06:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:06:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:06:17 INFO - Display Serial Number: 1600x1200 60 05:06:17 INFO - Main Display: Yes 05:06:17 INFO - Mirror: Off 05:06:17 INFO - Online: Yes 05:06:17 INFO - Rotation: Supported 05:06:17 INFO - Return code: 0 05:06:17 INFO - Running post-action listener: _resource_record_post_action 05:06:17 INFO - [mozharness: 2017-05-04 12:06:17.351389Z] Finished run-tests step (success) 05:06:17 INFO - Running post-run listener: _resource_record_post_run 05:06:17 INFO - Total resource usage - Wall time: 1197s; CPU: 54.0%; Read bytes: 40036864; Write bytes: 514732032; Read time: 255; Write time: 1708 05:06:17 INFO - TinderboxPrint: CPU usage
54.2% 05:06:17 INFO - TinderboxPrint: I/O read bytes / time
40,036,864 / 255 05:06:17 INFO - TinderboxPrint: I/O write bytes / time
514,732,032 / 1,708 05:06:17 INFO - TinderboxPrint: CPU idle
2,193.1 (45.8%) 05:06:17 INFO - TinderboxPrint: CPU system
966.5 (20.2%) 05:06:17 INFO - TinderboxPrint: CPU user
1,629.9 (34.0%) 05:06:17 INFO - TinderboxPrint: Swap in / out
248,410,112 / 0 05:06:17 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 194828800; Write bytes: 192360448; Read time: 15091; Write time: 427 05:06:17 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 39062016; Write bytes: 304097280; Read time: 242; Write time: 1224 05:06:17 INFO - Running post-run listener: _upload_blobber_files 05:06:17 INFO - Blob upload gear active. 05:06:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:06:17 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 05:06:17 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:06:17 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:06:18 INFO - (blobuploader) - INFO - Open directory for files ... 05:06:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:06:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:06:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:06:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:06:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:06:19 INFO - (blobuploader) - INFO - Done attempting. 05:06:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:06:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:06:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:06:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:06:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:06:20 INFO - (blobuploader) - INFO - Done attempting. 05:06:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:06:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:06:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:06:20 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:06:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:06:20 INFO - (blobuploader) - INFO - Done attempting. 05:06:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:06:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:06:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:06:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:06:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:06:22 INFO - (blobuploader) - INFO - Done attempting. 05:06:22 INFO - (blobuploader) - INFO - Iteration through files over. 05:06:22 INFO - Return code: 0 05:06:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:06:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:06:22 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a5a98e7ccd8c6cbfca0548834f429c8010655e77341a36ad213cce5c63bcfaa5d16228188dd286153c3dd38986cc44a198912abfafb0f5456c927e7720a0353c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2b2b25d76bfc426242375f5afdce813775b3831f18233f98b0c7fe45baf54381cb87c4c7009685ba853cca13a28f1d732fac2e54f31b5a27f8bba4c7ee1392c0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0f0c97eb46ac0ed867c5b102713cdf0f61cc8aa8461e103150dbde14f115f27cda937033a76ee365a76ccb93c209a7ba65d01782794c521f1c44b86b9e03bdb3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fb8eafaed9fcf62e5041006f67fc076f4d9daa879954bd3fed602ab54cfc117c08d6ebd2a925e2356c67b88579b4429d717739cbbbf4589b55c858abaf4ea462"} 05:06:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:06:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:06:22 INFO - Contents: 05:06:22 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a5a98e7ccd8c6cbfca0548834f429c8010655e77341a36ad213cce5c63bcfaa5d16228188dd286153c3dd38986cc44a198912abfafb0f5456c927e7720a0353c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2b2b25d76bfc426242375f5afdce813775b3831f18233f98b0c7fe45baf54381cb87c4c7009685ba853cca13a28f1d732fac2e54f31b5a27f8bba4c7ee1392c0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0f0c97eb46ac0ed867c5b102713cdf0f61cc8aa8461e103150dbde14f115f27cda937033a76ee365a76ccb93c209a7ba65d01782794c521f1c44b86b9e03bdb3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fb8eafaed9fcf62e5041006f67fc076f4d9daa879954bd3fed602ab54cfc117c08d6ebd2a925e2356c67b88579b4429d717739cbbbf4589b55c858abaf4ea462"} 05:06:22 INFO - Running post-run listener: copy_logs_to_upload_dir 05:06:22 INFO - Copying logs to upload dir... 05:06:22 INFO - mkdir: /builds/slave/test/build/upload/logs 05:06:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.071207 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2017-05-04 05:06:22.924784) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-04 05:06:22.928175) ========= 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.OQoKw3BQDd/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.lHUImak13K/Listeners TMPDIR=/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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/Firefox/sha512/a5a98e7ccd8c6cbfca0548834f429c8010655e77341a36ad213cce5c63bcfaa5d16228188dd286153c3dd38986cc44a198912abfafb0f5456c927e7720a0353c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2b2b25d76bfc426242375f5afdce813775b3831f18233f98b0c7fe45baf54381cb87c4c7009685ba853cca13a28f1d732fac2e54f31b5a27f8bba4c7ee1392c0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0f0c97eb46ac0ed867c5b102713cdf0f61cc8aa8461e103150dbde14f115f27cda937033a76ee365a76ccb93c209a7ba65d01782794c521f1c44b86b9e03bdb3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fb8eafaed9fcf62e5041006f67fc076f4d9daa879954bd3fed602ab54cfc117c08d6ebd2a925e2356c67b88579b4429d717739cbbbf4589b55c858abaf4ea462"} build_url:https://queue.taskcluster.net/v1/task/a3xjx-0rSQO3SRK0QXEI0Q/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011225 build_url: 'https://queue.taskcluster.net/v1/task/a3xjx-0rSQO3SRK0QXEI0Q/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a5a98e7ccd8c6cbfca0548834f429c8010655e77341a36ad213cce5c63bcfaa5d16228188dd286153c3dd38986cc44a198912abfafb0f5456c927e7720a0353c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2b2b25d76bfc426242375f5afdce813775b3831f18233f98b0c7fe45baf54381cb87c4c7009685ba853cca13a28f1d732fac2e54f31b5a27f8bba4c7ee1392c0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0f0c97eb46ac0ed867c5b102713cdf0f61cc8aa8461e103150dbde14f115f27cda937033a76ee365a76ccb93c209a7ba65d01782794c521f1c44b86b9e03bdb3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fb8eafaed9fcf62e5041006f67fc076f4d9daa879954bd3fed602ab54cfc117c08d6ebd2a925e2356c67b88579b4429d717739cbbbf4589b55c858abaf4ea462"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-04 05:06:22.967998) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 05:06:22.968435) ========= 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.OQoKw3BQDd/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.lHUImak13K/Listeners TMPDIR=/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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.005193 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 05:06:23.018258) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-04 05:06:23.018704) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-04 05:06:23.019102) ========= ========= Total master_lag: 0.19 =========