builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0390 starttime: 1496338031.96 results: success (0) revision: cac2fd43de81d44b36396704220996b0c4a39f1a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-01 10:27:11.957530) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-01 10:27:11.957945) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-01 10:27:11.958218) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-01 10:27:11.983170) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 10:27:11.983609) ========= 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.XJRYgieuF5/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.RI6Hac51Az/Listeners TMPDIR=/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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-06-01 10:27:11-- 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% 161M=0s 2017-06-01 10:27:12 (161 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.100956 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 10:27:12.107735) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 10:27:12.108046) ========= 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.XJRYgieuF5/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.RI6Hac51Az/Listeners TMPDIR=/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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.026518 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 10:27:12.156300) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-01 10:27:12.156720) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev cac2fd43de81d44b36396704220996b0c4a39f1a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev cac2fd43de81d44b36396704220996b0c4a39f1a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.XJRYgieuF5/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.RI6Hac51Az/Listeners TMPDIR=/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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-06-01 10:27:12,254 truncating revision to first 12 chars 2017-06-01 10:27:12,254 Setting DEBUG logging. 2017-06-01 10:27:12,254 attempt 1/10 2017-06-01 10:27:12,254 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/cac2fd43de81?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-01 10:27:13,394 unpacking tar archive at: mozilla-central-cac2fd43de81/testing/mozharness/ program finished with exit code 0 elapsedTime=1.416406 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-01 10:27:13.594917) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-01 10:27:13.595235) ========= script_repo_revision: cac2fd43de81d44b36396704220996b0c4a39f1a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-01 10:27:13.595610) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-01 10:27:13.595870) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-01 10:27:13.614875) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 22 mins, 19 secs) (at 2017-06-01 10:27:13.615222) ========= /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.XJRYgieuF5/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.RI6Hac51Az/Listeners TMPDIR=/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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 10:27:13 INFO - MultiFileLogger online at 20170601 10:27:13 in /builds/slave/test 10:27:13 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 10:27:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:27:13 INFO - {'append_to_log': False, 10:27:13 INFO - 'base_work_dir': '/builds/slave/test', 10:27:13 INFO - 'blob_upload_branch': 'Firefox', 10:27:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:27:13 INFO - 'branch': 'Firefox', 10:27:13 INFO - 'buildbot_json_path': 'buildprops.json', 10:27:13 INFO - 'config_files': ('talos/mac_config.py',), 10:27:13 INFO - 'default_actions': ('clobber', 10:27:13 INFO - 'read-buildbot-config', 10:27:13 INFO - 'download-and-extract', 10:27:13 INFO - 'populate-webroot', 10:27:13 INFO - 'create-virtualenv', 10:27:13 INFO - 'install', 10:27:13 INFO - 'setup-mitmproxy', 10:27:13 INFO - 'run-tests'), 10:27:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:27:13 INFO - 'download_minidump_stackwalk': True, 10:27:13 INFO - 'download_symbols': 'ondemand', 10:27:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:27:13 INFO - 'tooltool.py': '/tools/tooltool.py', 10:27:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:27:13 INFO - '/tools/misc-python/virtualenv.py')}, 10:27:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:27:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:27:13 INFO - 'gecko_profile': False, 10:27:13 INFO - 'gecko_profile_interval': 0, 10:27:13 INFO - 'installer_path': 'installer.exe', 10:27:13 INFO - 'log_level': 'info', 10:27:13 INFO - 'log_name': 'talos', 10:27:13 INFO - 'log_to_console': True, 10:27:13 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:27:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:27:13 INFO - 'opt_config_files': (), 10:27:13 INFO - 'pip_index': False, 10:27:13 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:27:13 INFO - 'cmd': ('bash', 10:27:13 INFO - '-c', 10:27:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:27:13 INFO - 'enabled': True, 10:27:13 INFO - 'halt_on_failure': False, 10:27:13 INFO - 'name': 'check_screen_resolution'},), 10:27:13 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:27:13 INFO - 'cmd': ('bash', 10:27:13 INFO - '-c', 10:27:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:27:13 INFO - 'enabled': True, 10:27:13 INFO - 'halt_on_failure': False, 10:27:13 INFO - 'name': 'check_screen_resolution'},), 10:27:13 INFO - 'run_cmd_checks_enabled': True, 10:27:13 INFO - 'suite': 'dromaeojs-e10s', 10:27:13 INFO - 'system_bits': '32', 10:27:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:27:13 INFO - 'title': 't-yosemite-r7-0390', 10:27:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:27:13 INFO - 'use_talos_json': True, 10:27:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:27:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:27:13 INFO - 'work_dir': 'build'} 10:27:13 INFO - [mozharness: 2017-06-01 17:27:13.818840Z] Running clobber step. 10:27:13 INFO - Running pre-action listener: _resource_record_pre_action 10:27:13 INFO - Running main action method: clobber 10:27:13 INFO - rmtree: /builds/slave/test/build 10:27:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:27:16 INFO - Running post-action listener: _resource_record_post_action 10:27:16 INFO - [mozharness: 2017-06-01 17:27:16.229669Z] Finished clobber step (success) 10:27:16 INFO - [mozharness: 2017-06-01 17:27:16.229749Z] Running read-buildbot-config step. 10:27:16 INFO - Running pre-action listener: _resource_record_pre_action 10:27:16 INFO - Running main action method: read_buildbot_config 10:27:16 INFO - Using buildbot properties: 10:27:16 INFO - { 10:27:16 INFO - "project": "", 10:27:16 INFO - "product": "firefox", 10:27:16 INFO - "who": "ryanvm@gmail.com", 10:27:16 INFO - "installer_path": "public/build/firefox-55.0a1.en-US.mac.dmg", 10:27:16 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 10:27:16 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 10:27:16 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 10:27:16 INFO - "stage_platform": "macosx64", 10:27:16 INFO - "basedir": "/builds/slave/test", 10:27:16 INFO - "buildnumber": 9, 10:27:16 INFO - "platform": "yosemite_r7", 10:27:16 INFO - "parent_task_id": "B4veWz6LTiavgUX6DJZ8eA", 10:27:16 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 10:27:16 INFO - "slavebuilddir": "test", 10:27:16 INFO - "taskId": "PY65Z-qvTWWgQGrD3wMGuA", 10:27:16 INFO - "branch": "mozilla-central", 10:27:16 INFO - "script_repo_revision": "production", 10:27:16 INFO - "revision": "cac2fd43de81d44b36396704220996b0c4a39f1a", 10:27:16 INFO - "slavename": "t-yosemite-r7-0390", 10:27:16 INFO - "repo_path": "mozilla-central" 10:27:16 INFO - } 10:27:16 INFO - Finding installer, test and symbols from parent task. 10:27:16 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PY65Z-qvTWWgQGrD3wMGuA'}, attempt #1 10:27:17 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PY65Z-qvTWWgQGrD3wMGuA'}, attempt #1 10:27:17 INFO - Task dependencies: SuGF4LCkTsO215y5kUELOQ B4veWz6LTiavgUX6DJZ8eA 10:27:17 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/B4veWz6LTiavgUX6DJZ8eA'}, attempt #1 10:27:17 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/B4veWz6LTiavgUX6DJZ8eA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 10:27:17 INFO - Set test_url: https://queue.taskcluster.net/v1/task/B4veWz6LTiavgUX6DJZ8eA/artifacts/public/build/test_packages.json 10:27:17 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/B4veWz6LTiavgUX6DJZ8eA/artifacts/public/build/target.crashreporter-symbols.zip 10:27:17 INFO - Running post-action listener: _resource_record_post_action 10:27:17 INFO - [mozharness: 2017-06-01 17:27:17.948510Z] Finished read-buildbot-config step (success) 10:27:17 INFO - [mozharness: 2017-06-01 17:27:17.948615Z] Running download-and-extract step. 10:27:17 INFO - Running pre-action listener: _resource_record_pre_action 10:27:17 INFO - Running main action method: download_and_extract 10:27:17 INFO - mkdir: /builds/slave/test/build/tests 10:27:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 10:27:17 INFO - trying https://queue.taskcluster.net/v1/task/B4veWz6LTiavgUX6DJZ8eA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 10:27:17 INFO - Downloading https://queue.taskcluster.net/v1/task/B4veWz6LTiavgUX6DJZ8eA/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 10:27:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/B4veWz6LTiavgUX6DJZ8eA/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 10:27:18 INFO - Downloaded 1325 bytes. 10:27:18 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 10:27:18 INFO - Using the following test package requirements: 10:27:18 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:27:18 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 10:27:18 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 10:27:18 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:27:18 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 10:27:18 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:27:18 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 10:27:18 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:27:18 INFO - u'jsshell-mac.zip'], 10:27:18 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:27:18 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 10:27:18 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 10:27:18 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:27:18 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 10:27:18 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:27:18 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 10:27:18 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:27:18 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 10:27:18 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:27:18 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 10:27:18 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:27:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/B4veWz6LTiavgUX6DJZ8eA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 10:27:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/B4veWz6LTiavgUX6DJZ8eA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:27:18 INFO - Fetch https://queue.taskcluster.net/v1/task/B4veWz6LTiavgUX6DJZ8eA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 10:27:20 INFO - Content-Length response header: 57630144 10:27:20 INFO - Bytes received: 57630144 10:27:38 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 10:27:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/B4veWz6LTiavgUX6DJZ8eA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 10:27:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/B4veWz6LTiavgUX6DJZ8eA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:27:38 INFO - Fetch https://queue.taskcluster.net/v1/task/B4veWz6LTiavgUX6DJZ8eA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 10:27:40 INFO - Content-Length response header: 57630144 10:27:40 INFO - Bytes received: 57630144 10:27:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/B4veWz6LTiavgUX6DJZ8eA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 10:27:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/B4veWz6LTiavgUX6DJZ8eA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 10:27:57 INFO - Fetch https://queue.taskcluster.net/v1/task/B4veWz6LTiavgUX6DJZ8eA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 10:27:59 INFO - Content-Length response header: 14447425 10:27:59 INFO - Bytes received: 14447425 10:27:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 10:27:59 INFO - trying https://queue.taskcluster.net/v1/task/B4veWz6LTiavgUX6DJZ8eA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 10:27:59 INFO - Downloading https://queue.taskcluster.net/v1/task/B4veWz6LTiavgUX6DJZ8eA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 10:27:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/B4veWz6LTiavgUX6DJZ8eA/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 10:28:01 INFO - Downloaded 67866347 bytes. 10:28:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/B4veWz6LTiavgUX6DJZ8eA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 10:28:01 INFO - mkdir: /builds/slave/test/properties 10:28:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:28:01 INFO - Writing to file /builds/slave/test/properties/build_url 10:28:01 INFO - Contents: 10:28:01 INFO - build_url:https://queue.taskcluster.net/v1/task/B4veWz6LTiavgUX6DJZ8eA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 10:28:01 INFO - Running post-action listener: _resource_record_post_action 10:28:01 INFO - Running post-action listener: set_extra_try_arguments 10:28:01 INFO - [mozharness: 2017-06-01 17:28:01.730908Z] Finished download-and-extract step (success) 10:28:01 INFO - [mozharness: 2017-06-01 17:28:01.731051Z] Running populate-webroot step. 10:28:01 INFO - Running pre-action listener: _resource_record_pre_action 10:28:01 INFO - Running main action method: populate_webroot 10:28:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:28:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:28:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:28:01 INFO - '--tppagecycles', 10:28:01 INFO - '7'], 10:28:01 INFO - 'tests': ['tsvgm']}}, 10:28:01 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:28:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:28:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:28:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:28:01 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 10:28:01 INFO - 'talos_options': ['--disable-e10s'], 10:28:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:28:01 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:28:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:28:01 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 10:28:01 INFO - 'talos_options': ['--disable-e10s'], 10:28:01 INFO - 'tests': ['damp', 'tps']}, 10:28:01 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:28:01 INFO - 'tests': ['damp', 'tps']}, 10:28:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:28:01 INFO - 'tests': ['dromaeo_dom']}, 10:28:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:28:01 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:28:01 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 10:28:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 10:28:01 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 10:28:01 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 10:28:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:28:01 INFO - 'tests': ['a11yr', 10:28:01 INFO - 'ts_paint', 10:28:01 INFO - 'tpaint', 10:28:01 INFO - 'sessionrestore', 10:28:01 INFO - 'sessionrestore_no_auto_restore', 10:28:01 INFO - 'tabpaint']}, 10:28:01 INFO - 'other-e10s': {'tests': ['a11yr', 10:28:01 INFO - 'ts_paint', 10:28:01 INFO - 'tpaint', 10:28:01 INFO - 'sessionrestore', 10:28:01 INFO - 'sessionrestore_no_auto_restore', 10:28:01 INFO - 'tabpaint']}, 10:28:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:28:01 INFO - 'ts_paint', 10:28:01 INFO - 'tpaint', 10:28:01 INFO - 'sessionrestore', 10:28:01 INFO - 'sessionrestore_no_auto_restore', 10:28:01 INFO - 'tabpaint']}, 10:28:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:28:01 INFO - 'ts_paint', 10:28:01 INFO - 'tpaint', 10:28:01 INFO - 'sessionrestore', 10:28:01 INFO - 'sessionrestore_no_auto_restore', 10:28:01 INFO - 'tabpaint']}, 10:28:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:28:01 INFO - 'tests': ['a11yr', 10:28:01 INFO - 'ts_paint', 10:28:01 INFO - 'tpaint', 10:28:01 INFO - 'sessionrestore', 10:28:01 INFO - 'sessionrestore_no_auto_restore', 10:28:01 INFO - 'tabpaint']}, 10:28:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:28:01 INFO - 'tests': ['a11yr', 10:28:01 INFO - 'ts_paint', 10:28:01 INFO - 'tpaint', 10:28:01 INFO - 'sessionrestore', 10:28:01 INFO - 'sessionrestore_no_auto_restore', 10:28:01 INFO - 'tabpaint']}, 10:28:01 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 10:28:01 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 10:28:01 INFO - 'bloom_basic_ref']}, 10:28:01 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set.zip', 10:28:01 INFO - 'talos_options': ['--mitmproxy', 10:28:01 INFO - 'mitmproxy-recording-1.mp', 10:28:01 INFO - '--firstNonBlankPaint'], 10:28:01 INFO - 'tests': ['Quantum_1']}, 10:28:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:28:01 INFO - 'tests': ['tsvgx', 10:28:01 INFO - 'tsvgr_opacity', 10:28:01 INFO - 'tart', 10:28:01 INFO - 'tscrollx', 10:28:01 INFO - 'cart', 10:28:01 INFO - 'tsvg_static']}, 10:28:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:28:01 INFO - 'tsvgr_opacity', 10:28:01 INFO - 'tart', 10:28:01 INFO - 'tscrollx', 10:28:01 INFO - 'cart', 10:28:01 INFO - 'tsvg_static']}, 10:28:01 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 10:28:01 INFO - 'talos_options': ['--disable-e10s'], 10:28:01 INFO - 'tests': ['tp5o']}, 10:28:01 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:28:01 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 10:28:01 INFO - 'talos_options': ['--disable-e10s', 10:28:01 INFO - '--xperf_path', 10:28:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:28:01 INFO - 'tests': ['tp5n']}, 10:28:01 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:28:01 INFO - 'talos_options': ['--xperf_path', 10:28:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:28:01 INFO - 'tests': ['tp5n']}}, 10:28:01 INFO - 'talos.zip': {'path': '', 10:28:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:28:01 INFO - Running post-action listener: _resource_record_post_action 10:28:01 INFO - [mozharness: 2017-06-01 17:28:01.753414Z] Finished populate-webroot step (success) 10:28:01 INFO - [mozharness: 2017-06-01 17:28:01.753582Z] Running create-virtualenv step. 10:28:01 INFO - Running pre-action listener: _resource_record_pre_action 10:28:01 INFO - Running main action method: create_virtualenv 10:28:01 INFO - Creating virtualenv /builds/slave/test/build/venv 10:28:01 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 10:28:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:28:01 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 10:28:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:28:01 INFO - Using real prefix '/tools/python27' 10:28:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:28:02 INFO - Installing distribute.............................................................................................................................................................................................done. 10:28:05 INFO - Installing pip.................done. 10:28:05 INFO - Return code: 0 10:28:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:28:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:28:05 INFO - Reading from file tmpfile_stdout 10:28:05 INFO - Output received: 10:28:05 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) 10:28:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:28:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 10:28:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:28:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 10:28:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:28: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/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 0x109211c10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109215768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3f8567400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10919ac60>, '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 0x108f2fcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108f58be8>, '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.XJRYgieuF5/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.RI6Hac51Az/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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 10:28:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 10:28:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:28:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XJRYgieuF5/Render', 10:28:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:28:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:28:05 INFO - 'HOME': '/Users/cltbld', 10:28:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:28:05 INFO - 'LOGNAME': 'cltbld', 10:28:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:28:05 INFO - 'MOZ_NO_REMOTE': '1', 10:28:05 INFO - 'NO_EM_RESTART': '1', 10:28:05 INFO - 'PAGER': '/bin/cat', 10:28:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:28:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:28:05 INFO - 'PWD': '/builds/slave/test', 10:28:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:28:05 INFO - 'SHELL': '/bin/bash', 10:28:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RI6Hac51Az/Listeners', 10:28:05 INFO - 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/', 10:28:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:28:05 INFO - 'USER': 'cltbld', 10:28:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:28:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:28:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:28:05 INFO - 'XPC_FLAGS': '0x0', 10:28:05 INFO - 'XPC_SERVICE_NAME': '0', 10:28:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:28:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:28:06 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:28:06 INFO - Cleaning up... 10:28:06 INFO - Return code: 0 10:28:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:28:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 10:28:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:28:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 10:28:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:28: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/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 0x109211c10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109215768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3f8567400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10919ac60>, '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 0x108f2fcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108f58be8>, '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.XJRYgieuF5/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.RI6Hac51Az/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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 10:28:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 10:28:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:28:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XJRYgieuF5/Render', 10:28:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:28:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:28:06 INFO - 'HOME': '/Users/cltbld', 10:28:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:28:06 INFO - 'LOGNAME': 'cltbld', 10:28:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:28:06 INFO - 'MOZ_NO_REMOTE': '1', 10:28:06 INFO - 'NO_EM_RESTART': '1', 10:28:06 INFO - 'PAGER': '/bin/cat', 10:28:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:28:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:28:06 INFO - 'PWD': '/builds/slave/test', 10:28:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:28:06 INFO - 'SHELL': '/bin/bash', 10:28:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RI6Hac51Az/Listeners', 10:28:06 INFO - 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/', 10:28:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:28:06 INFO - 'USER': 'cltbld', 10:28:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:28:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:28:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:28:06 INFO - 'XPC_FLAGS': '0x0', 10:28:06 INFO - 'XPC_SERVICE_NAME': '0', 10:28:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:28:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:28:06 INFO - Downloading/unpacking psutil>=3.1.1 10:28: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 10:28: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 10:28: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 10:28: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 10:28:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:28:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:28:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:28:08 INFO - Installing collected packages: psutil 10:28:08 INFO - Running setup.py install for psutil 10:28:08 INFO - building 'psutil._psutil_osx' extension 10:28:08 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 10:28:08 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 10:28:08 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 10:28:08 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 10:28:09 INFO - building 'psutil._psutil_posix' extension 10:28:09 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 10:28:09 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:28:09 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:28:09 INFO - ^ 10:28:09 INFO - 1 warning generated. 10:28:09 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 10:28:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:28:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:28:09 INFO - Successfully installed psutil 10:28:09 INFO - Cleaning up... 10:28:09 INFO - Return code: 0 10:28:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:28:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 10:28:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:28:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 10:28:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:28:09 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/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 0x109211c10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109215768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3f8567400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10919ac60>, '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 0x108f2fcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108f58be8>, '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.XJRYgieuF5/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.RI6Hac51Az/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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 10:28:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 10:28:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:28:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XJRYgieuF5/Render', 10:28:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:28:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:28:09 INFO - 'HOME': '/Users/cltbld', 10:28:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:28:09 INFO - 'LOGNAME': 'cltbld', 10:28:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:28:09 INFO - 'MOZ_NO_REMOTE': '1', 10:28:09 INFO - 'NO_EM_RESTART': '1', 10:28:09 INFO - 'PAGER': '/bin/cat', 10:28:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:28:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:28:09 INFO - 'PWD': '/builds/slave/test', 10:28:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:28:09 INFO - 'SHELL': '/bin/bash', 10:28:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RI6Hac51Az/Listeners', 10:28:09 INFO - 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/', 10:28:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:28:09 INFO - 'USER': 'cltbld', 10:28:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:28:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:28:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:28:09 INFO - 'XPC_FLAGS': '0x0', 10:28:09 INFO - 'XPC_SERVICE_NAME': '0', 10:28:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:28:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:28:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:28:09 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 10:28:09 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 10:28:09 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 10:28:09 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 10:28:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:28:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:28:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:28:11 INFO - Installing collected packages: mozsystemmonitor 10:28:11 INFO - Running setup.py install for mozsystemmonitor 10:28:12 INFO - Successfully installed mozsystemmonitor 10:28:12 INFO - Cleaning up... 10:28:12 INFO - Return code: 0 10:28:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:28:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 10:28:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:28:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 10:28:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:28:12 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/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 0x109211c10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109215768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3f8567400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10919ac60>, '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 0x108f2fcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108f58be8>, '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.XJRYgieuF5/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.RI6Hac51Az/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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 10:28:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 10:28:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:28:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XJRYgieuF5/Render', 10:28:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:28:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:28:12 INFO - 'HOME': '/Users/cltbld', 10:28:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:28:12 INFO - 'LOGNAME': 'cltbld', 10:28:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:28:12 INFO - 'MOZ_NO_REMOTE': '1', 10:28:12 INFO - 'NO_EM_RESTART': '1', 10:28:12 INFO - 'PAGER': '/bin/cat', 10:28:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:28:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:28:12 INFO - 'PWD': '/builds/slave/test', 10:28:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:28:12 INFO - 'SHELL': '/bin/bash', 10:28:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RI6Hac51Az/Listeners', 10:28:12 INFO - 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/', 10:28:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:28:12 INFO - 'USER': 'cltbld', 10:28:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:28:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:28:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:28:12 INFO - 'XPC_FLAGS': '0x0', 10:28:12 INFO - 'XPC_SERVICE_NAME': '0', 10:28:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:28:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:28:12 INFO - Downloading/unpacking jsonschema==2.5.1 10:28:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:28:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:28:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:28:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:28:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:28:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:28:13 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 10:28:13 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 10:28:13 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 10:28:13 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 10:28:13 INFO - Downloading functools32-3.2.3-2.tar.gz 10:28:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:28:14 INFO - warning: no files found matching '*.txt' 10:28:14 INFO - no previously-included directories found matching 'build' 10:28:14 INFO - no previously-included directories found matching 'dist' 10:28:14 INFO - no previously-included directories found matching '.git*' 10:28:14 INFO - Installing collected packages: jsonschema, functools32 10:28:14 INFO - Running setup.py install for functools32 10:28:14 INFO - warning: no files found matching '*.txt' 10:28:14 INFO - no previously-included directories found matching 'build' 10:28:14 INFO - no previously-included directories found matching 'dist' 10:28:14 INFO - no previously-included directories found matching '.git*' 10:28:14 INFO - Successfully installed jsonschema functools32 10:28:14 INFO - Cleaning up... 10:28:14 INFO - Return code: 0 10:28:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:28:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 10:28:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:28:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 10:28:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:28:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x109211c10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109215768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3f8567400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10919ac60>, '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 0x108f2fcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108f58be8>, '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.XJRYgieuF5/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.RI6Hac51Az/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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 10:28:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 10:28:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 10:28:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XJRYgieuF5/Render', 10:28:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:28:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:28:14 INFO - 'HOME': '/Users/cltbld', 10:28:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:28:14 INFO - 'LOGNAME': 'cltbld', 10:28:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:28:14 INFO - 'MOZ_NO_REMOTE': '1', 10:28:14 INFO - 'NO_EM_RESTART': '1', 10:28:14 INFO - 'PAGER': '/bin/cat', 10:28:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:28:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:28:14 INFO - 'PWD': '/builds/slave/test', 10:28:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:28:14 INFO - 'SHELL': '/bin/bash', 10:28:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RI6Hac51Az/Listeners', 10:28:14 INFO - 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/', 10:28:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:28:14 INFO - 'USER': 'cltbld', 10:28:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:28:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:28:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:28:14 INFO - 'XPC_FLAGS': '0x0', 10:28:14 INFO - 'XPC_SERVICE_NAME': '0', 10:28:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:28:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:28:14 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:28:14 INFO - Cleaning up... 10:28:14 INFO - Return code: 0 10:28:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:28:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 10:28:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:28:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 10:28:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:28:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x109211c10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109215768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3f8567400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10919ac60>, '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 0x108f2fcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108f58be8>, '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.XJRYgieuF5/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.RI6Hac51Az/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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 10:28:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 10:28:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:28:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XJRYgieuF5/Render', 10:28:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:28:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:28:14 INFO - 'HOME': '/Users/cltbld', 10:28:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:28:14 INFO - 'LOGNAME': 'cltbld', 10:28:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:28:14 INFO - 'MOZ_NO_REMOTE': '1', 10:28:14 INFO - 'NO_EM_RESTART': '1', 10:28:14 INFO - 'PAGER': '/bin/cat', 10:28:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:28:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:28:14 INFO - 'PWD': '/builds/slave/test', 10:28:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:28:14 INFO - 'SHELL': '/bin/bash', 10:28:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RI6Hac51Az/Listeners', 10:28:14 INFO - 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/', 10:28:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:28:14 INFO - 'USER': 'cltbld', 10:28:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:28:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:28:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:28:14 INFO - 'XPC_FLAGS': '0x0', 10:28:14 INFO - 'XPC_SERVICE_NAME': '0', 10:28:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:28:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:28:14 INFO - Downloading/unpacking blobuploader==1.2.4 10:28:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:28:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:28:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:28:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:28:16 INFO - Downloading blobuploader-1.2.4.tar.gz 10:28:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:28:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:28: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 10:28: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 10:28: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 10:28: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 10:28:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:28:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:28: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 10:28: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 10:28: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 10:28: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 10:28:17 INFO - Downloading docopt-0.6.1.tar.gz 10:28:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:28:17 INFO - Installing collected packages: blobuploader, requests, docopt 10:28:17 INFO - Running setup.py install for blobuploader 10:28:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:28:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:28:17 INFO - Running setup.py install for requests 10:28:17 INFO - Running setup.py install for docopt 10:28:17 INFO - Successfully installed blobuploader requests docopt 10:28:17 INFO - Cleaning up... 10:28:18 INFO - Return code: 0 10:28:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:28:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 10:28:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:28:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 10:28:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:28:18 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/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 0x109211c10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109215768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3f8567400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10919ac60>, '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 0x108f2fcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108f58be8>, '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.XJRYgieuF5/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.RI6Hac51Az/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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 10:28:18 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:28:18 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:28:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XJRYgieuF5/Render', 10:28:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:28:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:28:18 INFO - 'HOME': '/Users/cltbld', 10:28:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:28:18 INFO - 'LOGNAME': 'cltbld', 10:28:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:28:18 INFO - 'MOZ_NO_REMOTE': '1', 10:28:18 INFO - 'NO_EM_RESTART': '1', 10:28:18 INFO - 'PAGER': '/bin/cat', 10:28:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:28:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:28:18 INFO - 'PWD': '/builds/slave/test', 10:28:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:28:18 INFO - 'SHELL': '/bin/bash', 10:28:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RI6Hac51Az/Listeners', 10:28:18 INFO - 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/', 10:28:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:28:18 INFO - 'USER': 'cltbld', 10:28:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:28:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:28:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:28:18 INFO - 'XPC_FLAGS': '0x0', 10:28:18 INFO - 'XPC_SERVICE_NAME': '0', 10:28:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:28:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:28:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:28:18 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-7gmXa4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:28:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:28:18 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-42QBg1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:28:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:28:18 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-_szK7i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:28:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:28:18 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-tkH1GN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:28:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:28:18 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-9TsaCY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:28:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:28:18 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-KdbGC9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:28:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:28:18 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-8XZksy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:28:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:28:19 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-6wnu2l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:28:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:28:19 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-MruLZP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:28:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:28:19 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-z0aerF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:28:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:28:19 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-yKmHHK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:28:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:28:19 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-Ps8oh4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:28:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:28:19 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-yVjphO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:28:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:28:19 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-4f7Y2e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:28:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:28:19 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-dHBSAX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:28:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:28:19 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-LrjUTu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:28:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:28:19 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-FZkHWP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:28:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:28:20 INFO - Running setup.py install for manifestparser 10:28:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:28:20 INFO - Running setup.py install for mozcrash 10:28:20 INFO - Running setup.py install for mozdebug 10:28:20 INFO - Running setup.py install for mozdevice 10:28:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:28:20 INFO - Running setup.py install for mozfile 10:28:20 INFO - Running setup.py install for mozhttpd 10:28:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:28:20 INFO - Running setup.py install for mozinfo 10:28:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:28:21 INFO - Running setup.py install for mozInstall 10:28:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:28:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:28:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:28:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:28:21 INFO - Running setup.py install for mozleak 10:28:21 INFO - Running setup.py install for mozlog 10:28:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:28:21 INFO - Running setup.py install for moznetwork 10:28:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:28:21 INFO - Running setup.py install for mozprocess 10:28:21 INFO - Running setup.py install for mozprofile 10:28:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:28:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:28:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:28:21 INFO - Running setup.py install for mozrunner 10:28:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:28:22 INFO - Running setup.py install for mozscreenshot 10:28:22 INFO - Running setup.py install for moztest 10:28:22 INFO - Running setup.py install for mozversion 10:28:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:28:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:28:22 INFO - Cleaning up... 10:28:22 INFO - Return code: 0 10:28:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:28:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 10:28:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:28:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 10:28:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:28:22 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/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 0x109211c10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109215768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3f8567400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10919ac60>, '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 0x108f2fcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108f58be8>, '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.XJRYgieuF5/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.RI6Hac51Az/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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 10:28:22 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:28:22 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:28:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XJRYgieuF5/Render', 10:28:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:28:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:28:22 INFO - 'HOME': '/Users/cltbld', 10:28:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:28:22 INFO - 'LOGNAME': 'cltbld', 10:28:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:28:22 INFO - 'MOZ_NO_REMOTE': '1', 10:28:22 INFO - 'NO_EM_RESTART': '1', 10:28:22 INFO - 'PAGER': '/bin/cat', 10:28:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:28:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:28:22 INFO - 'PWD': '/builds/slave/test', 10:28:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:28:22 INFO - 'SHELL': '/bin/bash', 10:28:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RI6Hac51Az/Listeners', 10:28:22 INFO - 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/', 10:28:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:28:22 INFO - 'USER': 'cltbld', 10:28:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:28:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:28:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:28:22 INFO - 'XPC_FLAGS': '0x0', 10:28:22 INFO - 'XPC_SERVICE_NAME': '0', 10:28:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:28:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:28:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:28:22 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-BRhsae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:28:22 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)) 10:28:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:28:22 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-L_lw2J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:28:23 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)) 10:28:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:28:23 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-lhsGyA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:28:23 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)) 10:28:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:28:23 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-qfSlAv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:28:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 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)) 10:28:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:28:23 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-2MDT51-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:28:23 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)) 10:28:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:28:23 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-_nX5mf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:28:23 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)) 10:28:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:28:23 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-nc3KaU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:28:23 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)) 10:28:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:28:23 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-iHeoo3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:28:23 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)) 10:28:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:28:23 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-utKNsS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:28:23 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)) 10:28:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:28:23 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-TzqS0L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:28:23 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)) 10:28:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:28:23 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-oIVjDv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:28:24 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)) 10:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:28:24 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-VfglwZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:28:24 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)) 10:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:28:24 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-mfHVlc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:28:24 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)) 10:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:28:24 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-oOsd7Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:28:24 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)) 10:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:28:24 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-BEwkf5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:28:24 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)) 10:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:28:24 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-0paLNz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:28:24 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)) 10:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:28:24 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-AZvI8P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:28:24 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)) 10:28:24 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)) 10:28:24 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)) 10:28:24 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)) 10:28:24 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.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:28:24 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.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:28:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:28:24 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 10:28:24 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 10:28:24 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 10:28:24 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 10:28:26 INFO - Downloading blessings-1.6.tar.gz 10:28:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:28:26 INFO - Installing collected packages: blessings 10:28:26 INFO - Running setup.py install for blessings 10:28:26 INFO - Successfully installed blessings 10:28:26 INFO - Cleaning up... 10:28:26 INFO - Return code: 0 10:28:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:28:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:28:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:28:26 INFO - Reading from file tmpfile_stdout 10:28:26 INFO - Current package versions: 10:28:26 INFO - blessings == 1.6 10:28:26 INFO - blobuploader == 1.2.4 10:28:26 INFO - docopt == 0.6.1 10:28:26 INFO - functools32 == 3.2.3-2 10:28:26 INFO - jsonschema == 2.5.1 10:28:26 INFO - manifestparser == 1.1 10:28:26 INFO - mozInstall == 1.12 10:28:26 INFO - mozcrash == 1.0 10:28:26 INFO - mozdebug == 0.1 10:28:26 INFO - mozdevice == 0.51 10:28:26 INFO - mozfile == 1.2 10:28:26 INFO - mozhttpd == 0.7 10:28:26 INFO - mozinfo == 0.9 10:28:26 INFO - mozleak == 0.1 10:28:26 INFO - mozlog == 3.4 10:28:26 INFO - moznetwork == 0.27 10:28:26 INFO - mozprocess == 0.25 10:28:26 INFO - mozprofile == 0.28 10:28:26 INFO - mozrunner == 6.13 10:28:26 INFO - mozscreenshot == 0.1 10:28:26 INFO - mozsystemmonitor == 0.3 10:28:26 INFO - moztest == 0.8 10:28:26 INFO - mozversion == 1.4 10:28:26 INFO - psutil == 3.1.1 10:28:26 INFO - requests == 1.2.3 10:28:26 INFO - wsgiref == 0.1.2 10:28:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:28:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 10:28:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:28:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 10:28:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:28:26 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/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 0x109211c10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109215768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3f8567400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10919ac60>, '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 0x108f2fcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108f58be8>, '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.XJRYgieuF5/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.RI6Hac51Az/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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 10:28:26 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:28:26 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:28:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XJRYgieuF5/Render', 10:28:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:28:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:28:26 INFO - 'HOME': '/Users/cltbld', 10:28:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:28:26 INFO - 'LOGNAME': 'cltbld', 10:28:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:28:26 INFO - 'MOZ_NO_REMOTE': '1', 10:28:26 INFO - 'NO_EM_RESTART': '1', 10:28:26 INFO - 'PAGER': '/bin/cat', 10:28:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:28:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:28:26 INFO - 'PWD': '/builds/slave/test', 10:28:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:28:26 INFO - 'SHELL': '/bin/bash', 10:28:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RI6Hac51Az/Listeners', 10:28:26 INFO - 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/', 10:28:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:28:26 INFO - 'USER': 'cltbld', 10:28:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:28:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:28:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:28:26 INFO - 'XPC_FLAGS': '0x0', 10:28:26 INFO - 'XPC_SERVICE_NAME': '0', 10:28:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:28:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:28:26 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)) 10:28:26 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)) 10:28:26 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)) 10:28:26 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)) 10:28:26 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)) 10:28:26 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)) 10:28:26 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)) 10:28:26 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)) 10:28:26 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)) 10:28:26 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 10:28:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:28:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:28:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:28:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:28:28 INFO - Downloading marionette_driver-1.4.0.tar.gz 10:28:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 10:28:28 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)) 10:28:28 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)) 10:28:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 10:28:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 10:28:28 INFO - Installing collected packages: marionette-driver 10:28:28 INFO - Running setup.py install for marionette-driver 10:28:28 INFO - Successfully installed marionette-driver 10:28:28 INFO - Cleaning up... 10:28:28 INFO - Return code: 0 10:28:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:28:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 10:28:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:28:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 10:28:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:28:28 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/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 0x109211c10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109215768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3f8567400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10919ac60>, '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 0x108f2fcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108f58be8>, '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.XJRYgieuF5/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.RI6Hac51Az/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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 10:28:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:28:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:28:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XJRYgieuF5/Render', 10:28:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:28:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:28:28 INFO - 'HOME': '/Users/cltbld', 10:28:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:28:28 INFO - 'LOGNAME': 'cltbld', 10:28:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:28:28 INFO - 'MOZ_NO_REMOTE': '1', 10:28:28 INFO - 'NO_EM_RESTART': '1', 10:28:28 INFO - 'PAGER': '/bin/cat', 10:28:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:28:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:28:28 INFO - 'PWD': '/builds/slave/test', 10:28:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:28:28 INFO - 'SHELL': '/bin/bash', 10:28:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RI6Hac51Az/Listeners', 10:28:28 INFO - 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/', 10:28:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:28:28 INFO - 'USER': 'cltbld', 10:28:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:28:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:28:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:28:28 INFO - 'XPC_FLAGS': '0x0', 10:28:28 INFO - 'XPC_SERVICE_NAME': '0', 10:28:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:28:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:28:28 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:28:28 INFO - Cleaning up... 10:28:28 INFO - Return code: 0 10:28:28 INFO - Running post-action listener: _resource_record_post_action 10:28:28 INFO - Running post-action listener: _start_resource_monitoring 10:28:28 INFO - Starting resource monitoring. 10:28:28 INFO - [mozharness: 2017-06-01 17:28:28.949013Z] Finished create-virtualenv step (success) 10:28:28 INFO - [mozharness: 2017-06-01 17:28:28.949965Z] Running install step. 10:28:28 INFO - Running pre-action listener: _resource_record_pre_action 10:28:28 INFO - Running main action method: install 10:28:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:28:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:28:29 INFO - Reading from file tmpfile_stdout 10:28:29 INFO - Detecting whether we're running mozinstall >=1.0... 10:28:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:28:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:28:29 INFO - Reading from file tmpfile_stdout 10:28:29 INFO - Output received: 10:28:29 INFO - Usage: mozinstall [options] installer 10:28:29 INFO - Options: 10:28:29 INFO - -h, --help show this help message and exit 10:28:29 INFO - -d DEST, --destination=DEST 10:28:29 INFO - Directory to install application into. [default: 10:28:29 INFO - "/builds/slave/test"] 10:28:29 INFO - --app=APP Application being installed. [default: firefox] 10:28:29 INFO - mkdir: /builds/slave/test/build/application 10:28:29 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'] 10:28:29 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 10:28:51 INFO - Reading from file tmpfile_stdout 10:28:51 INFO - Output received: 10:28:51 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:28:51 INFO - Running post-action listener: _resource_record_post_action 10:28:51 INFO - [mozharness: 2017-06-01 17:28:51.298757Z] Finished install step (success) 10:28:51 INFO - [mozharness: 2017-06-01 17:28:51.298899Z] Running setup-mitmproxy step. 10:28:51 INFO - Running pre-action listener: _resource_record_pre_action 10:28:51 INFO - Running main action method: setup_mitmproxy 10:28:51 INFO - Skipping: mitmproxy is not required 10:28:51 INFO - Running post-action listener: _resource_record_post_action 10:28:51 INFO - [mozharness: 2017-06-01 17:28:51.299530Z] Finished setup-mitmproxy step (success) 10:28:51 INFO - [mozharness: 2017-06-01 17:28:51.299671Z] Running run-tests step. 10:28:51 INFO - Running pre-action listener: _resource_record_pre_action 10:28:51 INFO - Running main action method: run_tests 10:28:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:28:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:28:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:28:51 INFO - 2017-06-01 10:28:51.314 screenresolution[1637:7678] starting screenresolution argv=screenresolution get 10:28:51 INFO - 2017-06-01 10:28:51.316 screenresolution[1637:7678] Display 0: 1600x1200x32@60 10:28:51 INFO - 2017-06-01 10:28:51.322 screenresolution[1638:7680] starting screenresolution argv=screenresolution list 10:28:51 INFO - Available Modes on Display 0 10:28:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:28:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:28:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:28:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:28:51 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:28:51 INFO - Intel Iris: 10:28:51 INFO - Chipset Model: Intel Iris 10:28:51 INFO - Type: GPU 10:28:51 INFO - Bus: Built-In 10:28:51 INFO - VRAM (Dynamic, Max): 1536 MB 10:28:51 INFO - Vendor: Intel (0x8086) 10:28:51 INFO - Device ID: 0x0a2e 10:28:51 INFO - Revision ID: 0x0009 10:28:51 INFO - Displays: 10:28:51 INFO - Display: 10:28:51 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:28:51 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:28:51 INFO - Display Serial Number: 1600x1200 60 10:28:51 INFO - Main Display: Yes 10:28:51 INFO - Mirror: Off 10:28:51 INFO - Online: Yes 10:28:51 INFO - Rotation: Supported 10:28:51 INFO - Return code: 0 10:28:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:28:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:28:51 INFO - Python 2.7.3 10:28:51 INFO - Return code: 0 10:28:51 INFO - grabbing minidump binary from tooltool 10:28:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 10:28:51 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 0x10919ac60>, '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 0x108f2fcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108f58be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:28:51 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 10:28:51 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 10:28:51 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 10:28:51 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:28:51 INFO - Return code: 0 10:28:51 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:28:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:28:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:28:51 INFO - ENV: RUST_BACKTRACE is now 1 10:28:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:28:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:28:51 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/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/B4veWz6LTiavgUX6DJZ8eA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0390', '--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 10:28:51 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/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/B4veWz6LTiavgUX6DJZ8eA/artifacts/public/build/target.crashreporter-symbols.zip --title t-yosemite-r7-0390 --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 10:28:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XJRYgieuF5/Render', 10:28:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:28:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:28:51 INFO - 'HOME': '/Users/cltbld', 10:28:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:28:51 INFO - 'LOGNAME': 'cltbld', 10:28:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:28:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:28:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:28:51 INFO - 'MOZ_NO_REMOTE': '1', 10:28:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:28:51 INFO - 'NO_EM_RESTART': '1', 10:28:51 INFO - 'PAGER': '/bin/cat', 10:28:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:28:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:28:51 INFO - 'PWD': '/builds/slave/test', 10:28:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:28:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:28:51 INFO - 'RUST_BACKTRACE': '1', 10:28:51 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 10:28:51 INFO - 'SHELL': '/bin/bash', 10:28:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RI6Hac51Az/Listeners', 10:28:51 INFO - 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/', 10:28:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:28:51 INFO - 'USER': 'cltbld', 10:28:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:28:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:28:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:28:51 INFO - 'XPC_FLAGS': '0x0', 10:28:51 INFO - 'XPC_SERVICE_NAME': '0', 10:28:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:28:51 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/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/B4veWz6LTiavgUX6DJZ8eA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0390', '--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 10:28:51 INFO - mozversion application_buildid: 20170601085754 10:28:51 INFO - mozversion application_changeset: cac2fd43de81d44b36396704220996b0c4a39f1a 10:28:51 INFO - mozversion application_display_name: Nightly 10:28:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:28:51 INFO - mozversion application_name: Firefox 10:28:51 INFO - mozversion application_remotingname: firefox 10:28:51 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:28:51 INFO - mozversion application_vendor: Mozilla 10:28:51 INFO - mozversion application_version: 55.0a1 10:28:51 INFO - mozversion platform_buildid: 20170601085754 10:28:51 INFO - mozversion platform_changeset: cac2fd43de81d44b36396704220996b0c4a39f1a 10:28:51 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:28:51 INFO - mozversion platform_version: 55.0a1 10:28:51 INFO - using testdate: 1496338131 10:28:51 INFO - actual date: 1496338131 10:28:51 INFO - starting webserver on 'localhost:49222' 10:28:51 INFO - SUITE-START | Running 2 tests 10:28:51 INFO - TEST-START | dromaeo_css 10:28:51 INFO - operating with platform_type : mac_ 10:28:51 INFO - Initialising browser for dromaeo_css test... 10:28:51 INFO - Application command: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox http://localhost:49222/getInfo.html -foreground -profile /var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/tmpMNF3RK/profile 10:28:51 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox http://localhost:49222/getInfo.html -foreground) 10:29:25 INFO - TEST-INFO | 1648: killed by SIGTERM 10:29:25 INFO - Browser initialized. 10:29:25 INFO - Running cycle 1/1 for dromaeo_css test... 10:29:25 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/tmpMNF3RK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:29:27 INFO - PID 1658 | 2017-06-01 10:29:27.667 plugin-container[1659:8254] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4547, name = 'com.apple.tsm.portname' 10:29:27 INFO - PID 1658 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:29:27 INFO - PID 1658 | 2017-06-01 10:29:27.668 plugin-container[1659:8254] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0xa00b, name = 'com.apple.CFPasteboardClient' 10:29:27 INFO - PID 1658 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:29:27 INFO - PID 1658 | 2017-06-01 10:29:27.668 plugin-container[1659:8254] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:29:28 INFO - PID 1658 | 2017-06-01 10:29:28.488 plugin-container[1660:8301] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4943, name = 'com.apple.tsm.portname' 10:29:28 INFO - PID 1658 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:29:28 INFO - PID 1658 | 2017-06-01 10:29:28.488 plugin-container[1660:8301] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9b17, name = 'com.apple.CFPasteboardClient' 10:29:28 INFO - PID 1658 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:29:28 INFO - PID 1658 | 2017-06-01 10:29:28.488 plugin-container[1660:8301] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:29:37 INFO - PID 1658 | RSS: Main: 260567040 10:29:37 INFO - PID 1658 | 10:32:40 INFO - PID 1658 | Cycle 1(1): loaded http://localhost:49222/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49222/tests/dromaeo/cssquery-ext.html) 10:32:41 INFO - PID 1658 | RSS: Main: 269365248 10:32:41 INFO - PID 1658 | 10:35:44 INFO - PID 1658 | Cycle 1(1): loaded http://localhost:49222/tests/dromaeo/cssquery-ext.html (next: http://localhost:49222/tests/dromaeo/cssquery-jquery.html) 10:35:44 INFO - PID 1658 | RSS: Main: 283688960 10:35:44 INFO - PID 1658 | 10:38:46 INFO - PID 1658 | Cycle 1(1): loaded http://localhost:49222/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49222/tests/dromaeo/cssquery-mootools.html) 10:38:47 INFO - PID 1658 | RSS: Main: 283844608 10:38:47 INFO - PID 1658 | 10:41:48 INFO - PID 1658 | Cycle 1(1): loaded http://localhost:49222/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49222/tests/dromaeo/cssquery-prototype.html) 10:41:49 INFO - PID 1658 | RSS: Main: 287563776 10:41:49 INFO - PID 1658 | 10:44:52 INFO - PID 1658 | Cycle 1(1): loaded http://localhost:49222/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49222/tests/dromaeo/cssquery-yui.html) 10:44:52 INFO - PID 1658 | RSS: Main: 289730560 10:44:52 INFO - PID 1658 | 10:47:54 INFO - PID 1658 | Cycle 1(1): loaded http://localhost:49222/tests/dromaeo/cssquery-yui.html (next: http://localhost:49222/tests/dromaeo/cssquery-dojo.html) 10:47:55 INFO - PID 1658 | RSS: Main: 295952384 10:47:55 INFO - PID 1658 | 10:47:55 INFO - PID 1658 | __start_tp_report 10:47:55 INFO - PID 1658 | _x_x_mozilla_page_load 10:47:55 INFO - PID 1658 | _x_x_mozilla_page_load_details 10:47:55 INFO - PID 1658 | |i|pagename|runs| 10:47:55 INFO - PID 1658 | |0;dojo.html;3307.784993975392;3595.5325807645004;3635.872744453943;3639.781613103214;3656.689181419579;6179.165812615295;6186.072089186613;6209.565330426872;6228.252609686839;6242.063690446435;4837.830675926343;6207.162033125526;6243.594166379182;6253.218347706536;6301.117843501902;5325.227841962913;5494.395616482184;5494.5054945054935;5496.587755918302;5596.132599447093;5107.719075450848;5192.480751924796;5506.752196151183;5620;5623.915641265385;5393.514583687487;5420.214068960018;5511.063119269734;5524.447555244484;5552.694601796899;4513.842015529473;5548.528375088082;5549;5560.277163968699;5588.217649529029;5437.673739575638;5471.7264136793;5492.670439773627;5521.282233309684;5541.418151094117;6121.296050954153;6155.0151975683675;6189.690515474208;6272.40412160844;6273.686315684243;6729.2261389940295;6768.289329620368;6772.966135169342;6814.965925170342;6816.829579260509;6860.108185935796;6894.758683446105;6901.654917254167;6906.723731050752;6910.136232970879;6189.504839612865;6262.749490020348;6312.210973628296;6320.652364120017;6394.424501794861;6901.482388820858;7000;7016.087908571955;7039.718411263594;7061.152661680631;6422.710978005907;6544.770933017321;6550.70521826519;6610.7025183866845;6617.172853393326;6737.831554211184;6856.691448884812;6864.519483636098;6877.277885822016;6881.41507971828;6603.80188594343;6624.8343791405605;6636.170478690164;6652.201735791736;6667.499937504706;6534.215894092739;6640.369164929324;6650.733970641217;6719.361660642231;6797.592144471348;5423.7830486780085;5440.727963601804;5445.455454454523;5450.31871016123;5484.2596249506605;4746.359241502353;4807.254875494304;4830.758462076882;4833.951660483421;4846.8788280292565;6268.874622507525;6287.434130928238;6293.150424692608;6332.525060620472;6382.968085159545;6845.247022827485;6895.413889819321;6902.068220790229;6914.274001229899;6936.895946560806;6278.968605156945;6348.809535713936;6355.936440635627;6358.841028974312;6372.076048972873;4736.715797052188;4968.403791545038;5913.349531551526;5994.790182343597;6056.06131049688;7035.929640703527;7036.788896333118;7036.9296307036275;7065.788026359218;7098.183708873339;5718.914216286676;6879.5184337095925;6882.965585172042;6884.483663725341;6885.001674757233;6848.589084654936;6958.060661810793;7042.859142817218;7058.294170582901;7083.539569927938;6537.117489139096;6637.30308317639;6691.498137639599;6728.764493242713;6760.425363844129;6850.554713943578;6867.725290988305;6872.793816185523;6886.586804791728;6906.033155358355;5426.728663566885;6477.902831457438;6536.150300460909;6573.375529324707;6679.4990375721045;5574.163875418558;6589.868202636017;6615.37153970372;6636.568623039487;6645.833854153685;6465.612063276219;6501.609903405811;6543.672816359068;6557.147570815954;6558.245801732862;6454.515911306765;6468.579542329733;6533.67331633407;6664.566803157779;6690.264070952288;6374.075759014824;6483.124778154889;6493.935060649333;6502.674866256573;6508.674566271762 10:47:55 INFO - PID 1658 | |1;ext.html;763.8930549723038;784.4900814470593;848.8556945319295;1243.7699025680256;1308.4504508106595;39775.40336894945;40972.975675608126;40999;41009;41061.17877642449;40806.387904181385;41135.17729645405;41171.794141029255;41259.174816503655;41349.586504134946;8031.39764517662;8205.384596155282;8339.20777526134;8563.571821408936;8582.785430364229;8548.40161188717;8694.043655197924;8696.652133914637;8697.782555436133;8700.12998700128;8637.697680581181;8649.308055355588;8680.782980425509;8702.086280940504;8722;8669.479831210116;8698.652053917836;8707.085755995657;8717.825643487158;8718.476891386474;8410.285125764318;8481.703140390118;8484.151584841466;8486.27866631337;8486.915130848674;37790.24419511622;37883;37911.431328530096;37966;38014.23971520554;3489.982550087259;3501.0547152268746;3534.2224710563637;3534.876279330211;3545.2909418116224;30626.54060189099;30795.846020769975;30826.383472330654;30898.227544311347;30972.8451357744;3020.41101985113;3089.2276930767307;3096.14855914623;3098.643655979569;3112.813231206135;214408;216716.9164154185;217328.99999999843;273751;275599;49414.75292623514;49643.50356496461;49662;49759;49878.75060624674;50141.74929125331;51119.97760044778;51754;51929.480705192465;51945.48054519406;14475.348609312607;14680.632984175267;14681.853181468048;14706.191159486118;14728.968972172059;11617.825732614017;11735.88264117365;11846.229995050295;11857;11866;13861.653458663613;13971.510997115052;14009.509667161601;14051.71896562063;14157.575272741835;6273.278572964076;6299.6850157491945;6317.6209427434505;6356.2054743157105;6358.109864618957;882.9735107946772;898.7618281155499;977.4623956823718;1006.4766321512918;1036.657902892044;21492.785072149392;25182;25229.116980905947;25431.491370172494;25432.058031005225;1115.782422427635;1122.9831552526718;1125.960591379314;1135.0579019413867;1160.14729174057;10641;13002.934985325013;13037.739245215043;13067.477300907858;13098;342416;344110.2794486011;344364.2781786125;345333;345512;57100.143497847566;57355;57522.42477575171;57523.712381438665;57551.71224143852;1469.1552357394542;1490.3144553505508;1507.163524244055;1520.673055293095;1520.8631223189966;24667.753322467262;24803.87598061998;26990;29920;30394.392112158075;54290;54945;55030.44969550253;55144.62138446571;55261.618459537225;295616;296207;298190;298277.50861245557;298357;34922.82538587291;36974.445383318736;36974.8151259242;37146.25707485889;37204.44193337048;45865;45883;46522;46953;47210.76394618005;31135.84432077825;31518.896838610537;31974;32112.197195069377;32472.512912306807;27471.17586472409;28253.293667658472;31065.8446707765;31664.208394790316;32057.87797427079;38172.80913595414;38330.80834595809;38381.424278635284;38423.80788096153;38479.61520384761;29723.55414668825;30771;31301.373972520876;32502;32912.506312404854;22539.5492090154;23799.52400952006;24388;24597;25254.989800407777 10:47:55 INFO - PID 1658 | |2;jquery.html;408.70573187305143;413.59261127789125;427.0945595337884;432.96752743544243;457.66590389016017;14468.421263149488;15182.924085379585;21614.99999999998;22278.331650050503;22363.55272894541;22577.54844903101;23342.88328558355;23355.065797368086;23399.415014624643;23464.765352346472;6013.75944962201;6188.504919606443;6191.102290167923;6194.938050619504;6199.504039676815;6033.215681961339;6115.755369785204;6146.07808828677;6150.200473938382;6160.691965401712;5877.67672777997;5977.940220597782;5989.490893274077;6057.862586306389;6088.96955515224;5975.073863551156;5978.790742324019;6024.548158888101;6035.275766907977;6049.939500604982;5362.088444964365;5367.892642147174;5374.193870919355;5374.48942350476;5384.3538775346815;22127.778722212734;27462.17613471599;27764.722352776414;27795.722042779515;27821;2111.8627289226306;2161.373201771484;2212.5353675727956;2236.3402796175005;2237.105157936822;18520.073996300132;18641.72037419426;18683.906580467148;18786.90606546972;18801.623967520572;2146.302451703187;2187.442202238435;2215.3796936857543;2220.222921977311;2223.144089525528;186076.06961965104;187861.06069469565;187953.99999999863;190219;190591;10821.24251302417;12831.615051548468;13039.217646941213;13092.279924604049;13517.32413379327;13469;16647.583810404594;16654.417095401845;16743.74884376711;16816.32734690623;8970.551472426352;9019.458832470073;9183.448993060438;9234.399764015317;9321.021292764297;7273.89089163663;7319.377852882458;8907.910920890838;8920.598573064228;9027.638894444148;7539.71824789787;8127.552984585786;8182.4681395709085;8194.631241594143;8218.753437396888;1987.1753222412826;2121.8939053047284;2126.245182960027;2221.6112180368373;2234.229190929127;899.6356475627381;924.2467389078014;961.4183419031525;999.2256001598673;1000.4393146691185;18243.361482348053;19570.315038973567;20256.088476018616;20838.791612083685;21195.78804211969;791.6872835230051;971.4948226921961;983.5524836199512;999.8551658351147;1002.3935519011039;8344.539705551504;10274.948625256826;10755.83866242007;10884.719566602895;10896.291741036806;560861;569601;584088;590478;593838;152837.23581382245;161973.19013404858;163590;164143;165602.1719891393;1202.512982242176;1214.732758793064;1258.2827788160844;1259.4836117191908;1267.1889990406148;21408.571828563654;22067;22452.887735561217;22672.886635566716;22722.43193920165;68540.6572967132;68619;68927.65536172286;69067.30932690609;69831.65084174546;95593;95749.042509574;95912;96031;96168.51915740376;10078.596856125672;10165.33925294883;10234.283600147919;10238.692839214538;10253.179745620482;12766.234025958473;13119.540816071774;18066.1870215838;18097.276108955495;18245.178966946252;13958.930205348908;14476;14623.92688036553;14681.70636587241;14722.63193420173;12908.290044047668;13291.335433228493;13307.80038299407;13370.726976413838;13399.598012059654;13013.349332533524;14720.337584808924;15106.697866042838;15175.544733658007;15245.771313430529;9998.900010999796;10018.448985305587;10089.344192627455;10113.988601140121;10124.443155626512;14509.201993890438;14582.343794529485;14620.707585848437;14686.118832870063;14761.630959226106 10:47:55 INFO - PID 1658 | |3;mootools.html;1236.2891337480944;1332.8000799880017;1405.3043743347046;1417.8015077889095;1419.6663784010761;11688.064954803616;11863.406829658516;12334.506619735212;12338.938305308484;12365.381730913452;12083.818742718844;12213.633590992262;12304.63086107416;12324.198927069734;12324.5070197192;2429.6758266744578;2489.327881471997;2538.6826646669165;2542.0721436675667;2545.363659085229;2130.7123538322285;2230.1971290335546;2311.4221444638843;2511.3972646564785;2543.567593509108;2576.6135079738;2603.4923189977962;2613.202973093206;2615.712271650117;2622.803289753276;2528.1025236041214;2553.0553695132735;2557.8721063946728;2561.513312470634;2568.370749166457;2516.3331717094984;2529.4182338062164;2531.354504601315;2531.8227724059325;2539.7206307306183;11847;12076.637700868989;12126.333051682153;12154.33151176685;12168.81746773799;5864;5989.802039592056;6770.187577490733;6826.283240259801;6832.111825462708;4084.8978775530554;4109.301418758818;4339.153864996327;4346;4359.17175736609;1234.9012079033655;1272.198514935594;1286.5561381323428;1292.366740297257;1293.0948336164722;16749.162541872858;16879;16902.830971690248;16919.74620380683;16926.83073169277;5185.637005409585;5542.86142846424;5611;5676;5796.753817862011;12271.079669024859;12450.25298482094;12466.189697669623;12479.438425270884;12491;6369.108324834527;6501.187351581052;6585.176852893388;6604.273529911706;6611.173603299588;6010.609310394811;6207.751689932443;6221.129041934133;6232.220972378453;6250.1874756282305;4413;4527.818887244473;4541.863744087616;4554.72467709042;4555.476120246214;1171.2679575265458;1209.618970024457;1288.3429450980068;1296.9092163548462;1321.7752981993085;755.3768141283354;775.6005657086605;793.9325157361574;797.9960100199462;803.7669075968021;6805.557638753465;7033.683484243222;7073.540219885691;7111.928880711127;7312.5246858954;958.1855422890487;962.8122516109431;963.9855402168973;981.5730157381562;985.6895078050392;4253.97904502917;4379.802908869108;4563.817447302137;4604.7927843247135;4611.100835337077;14714.632134196516;15311.310991005432;15410;15449;15508.767368489482;14960.251987400587;15085.54743357701;15311.770323445156;15497.302621382065;15522.611934701497;8319.459235149696;8664.8700269496;8722.912770872337;8761.824763504694;8771.254443372385;6072.969635151972;6654.86867232562;6937.653117344214;7104.360607545345;7108.857822843411;13813.309334533033;13880.652983675489;14030.929845350707;14185.361658725176;14249.643758905695;13285.335733213495;14338.283085845458;14356.138631682132;14398.208098554262;14460.566183014527;9608.615655373707;9758.609655613696;9888.060634239735;9890.604375824887;9910.554025069034;10893.291936024134;10994.670159895217;11003.559857605605;11096.722581935515;11134.109271258441;9119.635214591342;9228.215601673934;9250.861237081584;9413.717588472357;9453.33826632129;9059.320550958573;9065.592048357708;9083.818323633623;9176;9186.816263674822;8298.834023319621;8396.496210227406;8441.915580844114;8444.36667249971;8456.027556831043;6041.18444010053;6051.183090282755;6137.508999279958;6194.101855231056;6331.27190373113;6088.208532890873;6161.137440758387;6298.716557755004;6331.303556608677;6394.424501794861 10:47:55 INFO - PID 1658 | |4;prototype.html;307.24877674086855;362.7098321342925;400.71749416661254;404.4964019795355;404.6883899397463;5298.549623282026;6469.320721324264;6502.349765023501;6514.543981921267;6522.739090436383;5579.898774400823;6106.633601983873;6154.692265386724;6299.590526615767;6351.555391122612;4531.614812740921;4585.747783871886;4610.354550362952;4614.930776038345;4652.371929789469;4610.216263235241;4611.2852507861335;4612.884677883047;4631.39791827062;4635.768211589424;3935.9016024599327;4578.267477203648;4580.725156490605;4594.678372513926;4685.578297953183;4576.679632425731;4578.862634120948;4579.954200458003;4591.8979444932975;4605.194091034055;3120.7659425542947;3878.3406820840523;3963.6829053675638;3970.7021973352116;3989.4614227079264;6190.783322583733;6192.969035154841;6205.534584906105;6226.813195604139;6226.866536461582;5528.806491772769;5532.419095994903;5532.612717109804;5534.391216966131;5557.749901254453;6786.405194779223;6809.727610895558;6815.897761533581;6819.24988251292;6841.2132604750095;4120.690948178869;4249.915001699979;4514.616257618107;4530.29780384041;4545.11370282795;4989.625778066659;6174.444300012976;6756.952672335796;7218.45861560385;7322.231165727575;3577.874774382884;4552.453705555355;4594.448666160015;4612;4624.606908412823;3717.5353080864893;4174.874753757392;4667.95332046682;4693.084848454587;4706.811727530929;4791.568758811654;5266.894662106736;5465.672059676433;5468.0977638689965;5487.64330318528;6703.028060931138;6767.868121541698;6778.32256258775;6783.152105986752;6819.430981242579;1383.9308034598432;1434.4579576954816;1591.3793620488018;1598.3846219205689;1599.9760003599956;888.684516996457;1034.3225187502198;1065.9360438373722;1066.3069005146717;1069.4652673663168;6426.518011149183;6458;6458.418742313214;6462.773802916875;6479.157709497735;6678.365555272241;7060.011598376232;7074.92925070753;7088.468364872655;7107.39587135089;5126.154184559506;6033.577649564576;6050.909236361458;6433.973298410986;6473.546851720429;3394.9151271218416;3654.538184726131;3690.2988432197794;3716.832742526593;3718.6095459976855;5704.973104841169;6624;7002.439804815603;7299.160596531361;7317.853642927112;7238.98654188414;7262.782116536512;7289.343959043712;7297.525660832029;7326.9267307326245;5358.866028349166;5560.388357280696;6049.425304596057;6526.955687090042;7323.523970941872;6987.965060174666;7080.575165490087;7081.433485321265;7098.0480367899245;7101.467389945671;5812.709364531672;6919.4710697543605;6970.198427180939;6986.685599147949;7026.964865175846;6736.427403670743;7179;7235.493515453868;7265.9273407265255;7277.3086556779135;4180.310248808913;4278.251306021371;4360.9345859812765;4551.135284295973;4601.608863246662;5873.883962047197;6180.258368995749;6428.19647544057;7056.576605403692;7081.291870812877;5858.004139296245;6202.193714817226;6313.589616674902;6788.59268443895;6828;6165.441341843085;6220.440160385587;6691.76578819739;6765.154355705537;6786.68837980663;6290.4144637556155;6570.507211959027;6654.234763002317;6665.533412661067;6671.766488172891;5678.602497825113;5814.651120932757;6421.422072013541;6773.62745049027;6777.830554236183;5541.5843811715085;6391.456726178327;6491.4806815455595;6602.7689030883685;6613.470922326299 10:47:55 INFO - PID 1658 | |5;yui.html;815.3069890592994;828.382854773194;849.9575021248936;866.5277423804026;874;14214.71570568588;14765.335559899804;16931.576710582227;17286.827131728678;17428.651426971453;17271.39550115746;17986.82013179868;18057.81942180578;18065.81934180658;18100.185491652875;961.0725649747992;973.522973742868;975.4050029482011;981.7398389426808;982.4891056650538;1027.9794404111913;1029.6344797596857;1029.6756521695643;1031.3914790273736;1031.6595523477235;942.6370847223834;1056.0653821368105;1059.502034043998;1063.2504084620364;1064.249703958711;1049.800537897797;1055.8310670292756;1057.7620035491952;1058.8252938265216;1059.1632610237903;776.4526009163526;777.2577188784697;778.2217782217782;778.4434129597365;778.8014056415634;17030.574235644082;17550.38573649916;17675.027873466955;17847.821521784746;18225.908870455696;17831.286748530045;17894.28422863084;17902.820971790246;18328.266869325213;18344.908275458536;14738.852611473962;14910.850891491054;15005.624859378493;15032.17323047232;15034;3576.6423357664285;3627.818609069536;3645.5989841117457;3671.596124426311;3691.8338674759702;129865.35067324602;130101;130692.99999999905;131318;131529;13549.932250338685;13766.518171863936;13797.172169669651;13889.652758681113;13893.513727019506;26254.868725656248;26807.051224365303;27224.183274501796;27248.727512724618;27251.182464526097;6748.426383757435;7819.0617125945255;7911.446198766032;7979.8404031919035;8045.0748163960725;3992.261431635157;4087.2642924273323;4094.672426205956;4097.078157414618;4100.5489396166395;4268.210381079511;4353.36876152956;4353.434053573015;4372.344148377769;4372.606465418127;934.7709811096189;947.8625599288065;953.6471505542994;954.4130359828655;955.9091886270793;633.2938773267773;656.0913135307538;662.6686656671665;667.6695035957232;672.7712577723597;11263;12149.420575325152;12391.690207744878;12444.191127576678;12642.873571264354;635.237714742311;637.4549759955264;643.7103303513437;647.7150053976235;666.2504682232488;4962.379702537183;5602.719864006865;5619.353774315924;5694.572907031989;5849.356570777211;125595.74404256023;134461.32769336092;135907;137309;140107.29946350204;119480.61038779176;120691.39654301848;121811;125844.2618057347;126926.36536817442;82117.76823347654;103408.96591033993;104178.47910760398;104387.39031524272;107582;12411.813822792485;12954.676133096747;13007.219566826021;13025.413856376676;13048.608541743763;40840.978975525846;45059.77470112628;45124.548754512034;45220.09559808851;45532.31701524414;71540.56918861698;73680.89478657718;83906.16093838983;85256.14743852481;85980.57009714912;17972.460826175236;18075.909620451814;18164.364247251284;18174;18344.816551834312;18297.085145742927;19142.8085719141;19562.60874782468;19730.40808775739;19845;15304.617384565476;18223.45329640113;18268.26926922908;18640.533986650444;18884.33904813325;16937.91531042337;18387.356442524448;18434.81565184331;18469.72295415543;18657.253709851455;17054.317827287265;17290.481285561455;18229.54426139304;18343.63312733711;18355.54111147232;10869.619364062546;12009.339486327986;12458.563950261698;12636.32311425861;12705.745885082431;11544.769104618028;12046.457909393923;12166.695832603902;14401.567952961428;14521.636959076108 10:47:55 INFO - PID 1658 | __end_tp_report 10:47:55 INFO - PID 1658 | __start_cc_report 10:47:55 INFO - PID 1658 | _x_x_mozilla_cycle_collect,457 10:47:55 INFO - PID 1658 | __end_cc_report 10:47:55 INFO - PID 1658 | __startTimestamp1496339275024__endTimestamp 10:47:55 INFO - PID 1658 | 10:47:55 INFO - PID 1658 | ------- Summary: start ------- 10:47:55 INFO - PID 1658 | Number of tests: 6 10:47:55 INFO - PID 1658 | 10:47:55 INFO - PID 1658 | [#0] dojo.html Cycles:165 Average:6204.53 Median:6468.58 stddev:779.32 (12.0%) stddev-sans-first:747.84 10:47:55 INFO - PID 1658 | Values: 3307.8 3595.5 3635.9 3639.8 3656.7 6179.2 6186.1 6209.6 6228.3 6242.1 4837.8 6207.2 6243.6 6253.2 6301.1 5325.2 5494.4 5494.5 5496.6 5596.1 5107.7 5192.5 5506.8 5620.0 5623.9 5393.5 5420.2 5511.1 5524.4 5552.7 4513.8 5548.5 5549.0 5560.3 5588.2 5437.7 5471.7 5492.7 5521.3 5541.4 6121.3 6155.0 6189.7 6272.4 6273.7 6729.2 6768.3 6773.0 6815.0 6816.8 6860.1 6894.8 6901.7 6906.7 6910.1 6189.5 6262.7 6312.2 6320.7 6394.4 6901.5 7000.0 7016.1 7039.7 7061.2 6422.7 6544.8 6550.7 6610.7 6617.2 6737.8 6856.7 6864.5 6877.3 6881.4 6603.8 6624.8 6636.2 6652.2 6667.5 6534.2 6640.4 6650.7 6719.4 6797.6 5423.8 5440.7 5445.5 5450.3 5484.3 4746.4 4807.3 4830.8 4834.0 4846.9 6268.9 6287.4 6293.2 6332.5 6383.0 6845.2 6895.4 6902.1 6914.3 6936.9 6279.0 6348.8 6355.9 6358.8 6372.1 4736.7 4968.4 5913.3 5994.8 6056.1 7035.9 7036.8 7036.9 7065.8 7098.2 5718.9 6879.5 6883.0 6884.5 6885.0 6848.6 6958.1 7042.9 7058.3 7083.5 6537.1 6637.3 6691.5 6728.8 6760.4 6850.6 6867.7 6872.8 6886.6 6906.0 5426.7 6477.9 6536.2 6573.4 6679.5 5574.2 6589.9 6615.4 6636.6 6645.8 6465.6 6501.6 6543.7 6557.1 6558.2 6454.5 6468.6 6533.7 6664.6 6690.3 6374.1 6483.1 6493.9 6502.7 6508.7 10:47:55 INFO - PID 1658 | 10:47:55 INFO - PID 1658 | [#1] ext.html Cycles:180 Average:45821.35 Median:19211.94 stddev:77989.58 (405.9%) stddev-sans-first:78134.98 10:47:55 INFO - PID 1658 | Values: 763.9 784.5 848.9 1243.8 1308.5 39775.4 40973.0 40999.0 41009.0 41061.2 40806.4 41135.2 41171.8 41259.2 41349.6 8031.4 8205.4 8339.2 8563.6 8582.8 8548.4 8694.0 8696.7 8697.8 8700.1 8637.7 8649.3 8680.8 8702.1 8722.0 8669.5 8698.7 8707.1 8717.8 8718.5 8410.3 8481.7 8484.2 8486.3 8486.9 37790.2 37883.0 37911.4 37966.0 38014.2 3490.0 3501.1 3534.2 3534.9 3545.3 30626.5 30795.8 30826.4 30898.2 30972.8 3020.4 3089.2 3096.1 3098.6 3112.8 214408.0 216716.9 217329.0 273751.0 275599.0 49414.8 49643.5 49662.0 49759.0 49878.8 50141.7 51120.0 51754.0 51929.5 51945.5 14475.3 14680.6 14681.9 14706.2 14729.0 11617.8 11735.9 11846.2 11857.0 11866.0 13861.7 13971.5 14009.5 14051.7 14157.6 6273.3 6299.7 6317.6 6356.2 6358.1 883.0 898.8 977.5 1006.5 1036.7 21492.8 25182.0 25229.1 25431.5 25432.1 1115.8 1123.0 1126.0 1135.1 1160.1 10641.0 13002.9 13037.7 13067.5 13098.0 342416.0 344110.3 344364.3 345333.0 345512.0 57100.1 57355.0 57522.4 57523.7 57551.7 1469.2 1490.3 1507.2 1520.7 1520.9 24667.8 24803.9 26990.0 29920.0 30394.4 54290.0 54945.0 55030.4 55144.6 55261.6 295616.0 296207.0 298190.0 298277.5 298357.0 34922.8 36974.4 36974.8 37146.3 37204.4 45865.0 45883.0 46522.0 46953.0 47210.8 31135.8 31518.9 31974.0 32112.2 32472.5 27471.2 28253.3 31065.8 31664.2 32057.9 38172.8 38330.8 38381.4 38423.8 38479.6 29723.6 30771.0 31301.4 32502.0 32912.5 22539.5 23799.5 24388.0 24597.0 25255.0 10:47:55 INFO - PID 1658 | 10:47:55 INFO - PID 1658 | [#2] jquery.html Cycles:180 Average:39510.38 Median:2220.92 stddev:100397.41 (4520.5%) stddev-sans-first:100636.12 10:47:55 INFO - PID 1658 | Values: 408.7 413.6 427.1 433.0 457.7 14468.4 15182.9 21615.0 22278.3 22363.6 22577.5 23342.9 23355.1 23399.4 23464.8 6013.8 6188.5 6191.1 6194.9 6199.5 6033.2 6115.8 6146.1 6150.2 6160.7 5877.7 5977.9 5989.5 6057.9 6089.0 5975.1 5978.8 6024.5 6035.3 6049.9 5362.1 5367.9 5374.2 5374.5 5384.4 22127.8 27462.2 27764.7 27795.7 27821.0 2111.9 2161.4 2212.5 2236.3 2237.1 18520.1 18641.7 18683.9 18786.9 18801.6 2146.3 2187.4 2215.4 2220.2 2223.1 186076.1 187861.1 187954.0 190219.0 190591.0 10821.2 12831.6 13039.2 13092.3 13517.3 13469.0 16647.6 16654.4 16743.7 16816.3 8970.6 9019.5 9183.4 9234.4 9321.0 7273.9 7319.4 8907.9 8920.6 9027.6 7539.7 8127.6 8182.5 8194.6 8218.8 1987.2 2121.9 2126.2 2221.6 2234.2 899.6 924.2 961.4 999.2 1000.4 18243.4 19570.3 20256.1 20838.8 21195.8 791.7 971.5 983.6 999.9 1002.4 8344.5 10274.9 10755.8 10884.7 10896.3 560861.0 569601.0 584088.0 590478.0 593838.0 152837.2 161973.2 163590.0 164143.0 165602.2 1202.5 1214.7 1258.3 1259.5 1267.2 21408.6 22067.0 22452.9 22672.9 22722.4 68540.7 68619.0 68927.7 69067.3 69831.7 95593.0 95749.0 95912.0 96031.0 96168.5 10078.6 10165.3 10234.3 10238.7 10253.2 12766.2 13119.5 18066.2 18097.3 18245.2 13958.9 14476.0 14623.9 14681.7 14722.6 12908.3 13291.3 13307.8 13370.7 13399.6 13013.3 14720.3 15106.7 15175.5 15245.8 9998.9 10018.4 10089.3 10114.0 10124.4 14509.2 14582.3 14620.7 14686.1 14761.6 10:47:55 INFO - PID 1658 | 10:47:55 INFO - PID 1658 | [#3] mootools.html Cycles:180 Average:7312.06 Median:4097.10 stddev:4663.27 (113.8%) stddev-sans-first:4653.99 10:47:55 INFO - PID 1658 | Values: 1236.3 1332.8 1405.3 1417.8 1419.7 11688.1 11863.4 12334.5 12338.9 12365.4 12083.8 12213.6 12304.6 12324.2 12324.5 2429.7 2489.3 2538.7 2542.1 2545.4 2130.7 2230.2 2311.4 2511.4 2543.6 2576.6 2603.5 2613.2 2615.7 2622.8 2528.1 2553.1 2557.9 2561.5 2568.4 2516.3 2529.4 2531.4 2531.8 2539.7 11847.0 12076.6 12126.3 12154.3 12168.8 5864.0 5989.8 6770.2 6826.3 6832.1 4084.9 4109.3 4339.2 4346.0 4359.2 1234.9 1272.2 1286.6 1292.4 1293.1 16749.2 16879.0 16902.8 16919.7 16926.8 5185.6 5542.9 5611.0 5676.0 5796.8 12271.1 12450.3 12466.2 12479.4 12491.0 6369.1 6501.2 6585.2 6604.3 6611.2 6010.6 6207.8 6221.1 6232.2 6250.2 4413.0 4527.8 4541.9 4554.7 4555.5 1171.3 1209.6 1288.3 1296.9 1321.8 755.4 775.6 793.9 798.0 803.8 6805.6 7033.7 7073.5 7111.9 7312.5 958.2 962.8 964.0 981.6 985.7 4254.0 4379.8 4563.8 4604.8 4611.1 14714.6 15311.3 15410.0 15449.0 15508.8 14960.3 15085.5 15311.8 15497.3 15522.6 8319.5 8664.9 8722.9 8761.8 8771.3 6073.0 6654.9 6937.7 7104.4 7108.9 13813.3 13880.7 14030.9 14185.4 14249.6 13285.3 14338.3 14356.1 14398.2 14460.6 9608.6 9758.6 9888.1 9890.6 9910.6 10893.3 10994.7 11003.6 11096.7 11134.1 9119.6 9228.2 9250.9 9413.7 9453.3 9059.3 9065.6 9083.8 9176.0 9186.8 8298.8 8396.5 8441.9 8444.4 8456.0 6041.2 6051.2 6137.5 6194.1 6331.3 6088.2 6161.1 6298.7 6331.3 6394.4 10:47:55 INFO - PID 1658 | 10:47:55 INFO - PID 1658 | [#4] prototype.html Cycles:180 Average:5416.22 Median:6130.66 stddev:1730.26 (28.2%) stddev-sans-first:1692.09 10:47:55 INFO - PID 1658 | Values: 307.2 362.7 400.7 404.5 404.7 5298.5 6469.3 6502.3 6514.5 6522.7 5579.9 6106.6 6154.7 6299.6 6351.6 4531.6 4585.7 4610.4 4614.9 4652.4 4610.2 4611.3 4612.9 4631.4 4635.8 3935.9 4578.3 4580.7 4594.7 4685.6 4576.7 4578.9 4580.0 4591.9 4605.2 3120.8 3878.3 3963.7 3970.7 3989.5 6190.8 6193.0 6205.5 6226.8 6226.9 5528.8 5532.4 5532.6 5534.4 5557.7 6786.4 6809.7 6815.9 6819.2 6841.2 4120.7 4249.9 4514.6 4530.3 4545.1 4989.6 6174.4 6757.0 7218.5 7322.2 3577.9 4552.5 4594.4 4612.0 4624.6 3717.5 4174.9 4668.0 4693.1 4706.8 4791.6 5266.9 5465.7 5468.1 5487.6 6703.0 6767.9 6778.3 6783.2 6819.4 1383.9 1434.5 1591.4 1598.4 1600.0 888.7 1034.3 1065.9 1066.3 1069.5 6426.5 6458.0 6458.4 6462.8 6479.2 6678.4 7060.0 7074.9 7088.5 7107.4 5126.2 6033.6 6050.9 6434.0 6473.5 3394.9 3654.5 3690.3 3716.8 3718.6 5705.0 6624.0 7002.4 7299.2 7317.9 7239.0 7262.8 7289.3 7297.5 7326.9 5358.9 5560.4 6049.4 6527.0 7323.5 6988.0 7080.6 7081.4 7098.0 7101.5 5812.7 6919.5 6970.2 6986.7 7027.0 6736.4 7179.0 7235.5 7265.9 7277.3 4180.3 4278.3 4360.9 4551.1 4601.6 5873.9 6180.3 6428.2 7056.6 7081.3 5858.0 6202.2 6313.6 6788.6 6828.0 6165.4 6220.4 6691.8 6765.2 6786.7 6290.4 6570.5 6654.2 6665.5 6671.8 5678.6 5814.7 6421.4 6773.6 6777.8 5541.6 6391.5 6491.5 6602.8 6613.5 10:47:55 INFO - PID 1658 | 10:47:55 INFO - PID 1658 | [#5] yui.html Cycles:180 Average:25369.53 Median:18248.91 stddev:37589.64 (206.0%) stddev-sans-first:37649.87 10:47:55 INFO - PID 1658 | Values: 815.3 828.4 850.0 866.5 874.0 14214.7 14765.3 16931.6 17286.8 17428.7 17271.4 17986.8 18057.8 18065.8 18100.2 961.1 973.5 975.4 981.7 982.5 1028.0 1029.6 1029.7 1031.4 1031.7 942.6 1056.1 1059.5 1063.3 1064.2 1049.8 1055.8 1057.8 1058.8 1059.2 776.5 777.3 778.2 778.4 778.8 17030.6 17550.4 17675.0 17847.8 18225.9 17831.3 17894.3 17902.8 18328.3 18344.9 14738.9 14910.9 15005.6 15032.2 15034.0 3576.6 3627.8 3645.6 3671.6 3691.8 129865.4 130101.0 130693.0 131318.0 131529.0 13549.9 13766.5 13797.2 13889.7 13893.5 26254.9 26807.1 27224.2 27248.7 27251.2 6748.4 7819.1 7911.4 7979.8 8045.1 3992.3 4087.3 4094.7 4097.1 4100.5 4268.2 4353.4 4353.4 4372.3 4372.6 934.8 947.9 953.6 954.4 955.9 633.3 656.1 662.7 667.7 672.8 11263.0 12149.4 12391.7 12444.2 12642.9 635.2 637.5 643.7 647.7 666.3 4962.4 5602.7 5619.4 5694.6 5849.4 125595.7 134461.3 135907.0 137309.0 140107.3 119480.6 120691.4 121811.0 125844.3 126926.4 82117.8 103409.0 104178.5 104387.4 107582.0 12411.8 12954.7 13007.2 13025.4 13048.6 40841.0 45059.8 45124.5 45220.1 45532.3 71540.6 73680.9 83906.2 85256.1 85980.6 17972.5 18075.9 18164.4 18174.0 18344.8 18297.1 19142.8 19562.6 19730.4 19845.0 15304.6 18223.5 18268.3 18640.5 18884.3 16937.9 18387.4 18434.8 18469.7 18657.3 17054.3 17290.5 18229.5 18343.6 18355.5 10869.6 12009.3 12458.6 12636.3 12705.7 11544.8 12046.5 12166.7 14401.6 14521.6 10:47:55 INFO - PID 1658 | -------- Summary: end -------- 10:47:55 INFO - PID 1658 | 10:47:55 INFO - TEST-INFO | 1658: exit 0 10:47:55 INFO - TEST-OK | dromaeo_css | took 1143671ms 10:47:55 INFO - TEST-START | kraken 10:47:55 INFO - operating with platform_type : mac_ 10:47:55 INFO - Initialising browser for kraken test... 10:47:55 INFO - Application command: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox http://localhost:49222/getInfo.html -foreground -profile /var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/tmpWWjj5S/profile 10:47:55 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox http://localhost:49222/getInfo.html -foreground) 10:48:29 INFO - TEST-INFO | 1669: killed by SIGTERM 10:48:29 INFO - Browser initialized. 10:48:29 INFO - Running cycle 1/1 for kraken test... 10:48:29 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/tmpWWjj5S/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:48:31 INFO - PID 1673 | 2017-06-01 10:48:31.659 plugin-container[1674:10874] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9943, name = 'com.apple.tsm.portname' 10:48:31 INFO - PID 1673 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:48:31 INFO - PID 1673 | 2017-06-01 10:48:31.660 plugin-container[1674:10874] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4907, name = 'com.apple.CFPasteboardClient' 10:48:31 INFO - PID 1673 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:48:31 INFO - PID 1673 | 2017-06-01 10:48:31.660 plugin-container[1674:10874] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:48:32 INFO - PID 1673 | 2017-06-01 10:48:32.166 plugin-container[1675:10921] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9743, name = 'com.apple.tsm.portname' 10:48:32 INFO - PID 1673 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:48:32 INFO - PID 1673 | 2017-06-01 10:48:32.167 plugin-container[1675:10921] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9a0b, name = 'com.apple.CFPasteboardClient' 10:48:32 INFO - PID 1673 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:48:32 INFO - PID 1673 | 2017-06-01 10:48:32.167 plugin-container[1675:10921] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:48:41 INFO - PID 1673 | RSS: Main: 268394496 10:48:41 INFO - PID 1673 | 10:48:44 INFO - PID 1673 | Cycle 1(1): loaded http://localhost:49222/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49222/tests/kraken/driver.html?testName=audio-beat-detection) 10:48:45 INFO - PID 1673 | RSS: Main: 276553728 10:48:45 INFO - PID 1673 | 10:48:47 INFO - PID 1673 | Cycle 1(1): loaded http://localhost:49222/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49222/tests/kraken/driver.html?testName=audio-dft) 10:48:48 INFO - PID 1673 | RSS: Main: 284303360 10:48:48 INFO - PID 1673 | 10:48:51 INFO - PID 1673 | Cycle 1(1): loaded http://localhost:49222/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49222/tests/kraken/driver.html?testName=audio-fft) 10:48:52 INFO - PID 1673 | RSS: Main: 283602944 10:48:52 INFO - PID 1673 | 10:48:54 INFO - PID 1673 | Cycle 1(1): loaded http://localhost:49222/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49222/tests/kraken/driver.html?testName=audio-oscillator) 10:48:54 INFO - PID 1673 | RSS: Main: 287154176 10:48:54 INFO - PID 1673 | 10:48:57 INFO - PID 1673 | Cycle 1(1): loaded http://localhost:49222/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49222/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:48:57 INFO - PID 1673 | RSS: Main: 287158272 10:48:57 INFO - PID 1673 | 10:49:00 INFO - PID 1673 | Cycle 1(1): loaded http://localhost:49222/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49222/tests/kraken/driver.html?testName=imaging-darkroom) 10:49:01 INFO - PID 1673 | RSS: Main: 291864576 10:49:01 INFO - PID 1673 | 10:49:04 INFO - PID 1673 | Cycle 1(1): loaded http://localhost:49222/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49222/tests/kraken/driver.html?testName=imaging-desaturate) 10:49:04 INFO - PID 1673 | RSS: Main: 294670336 10:49:04 INFO - PID 1673 | 10:49:07 INFO - PID 1673 | Cycle 1(1): loaded http://localhost:49222/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49222/tests/kraken/driver.html?testName=json-parse-financial) 10:49:08 INFO - PID 1673 | RSS: Main: 293920768 10:49:08 INFO - PID 1673 | 10:49:09 INFO - PID 1673 | Cycle 1(1): loaded http://localhost:49222/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49222/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:49:10 INFO - PID 1673 | RSS: Main: 293539840 10:49:10 INFO - PID 1673 | 10:49:12 INFO - PID 1673 | Cycle 1(1): loaded http://localhost:49222/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49222/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:49:12 INFO - PID 1673 | RSS: Main: 292990976 10:49:12 INFO - PID 1673 | 10:49:15 INFO - PID 1673 | Cycle 1(1): loaded http://localhost:49222/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49222/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:49:15 INFO - PID 1673 | RSS: Main: 292818944 10:49:15 INFO - PID 1673 | 10:49:18 INFO - PID 1673 | Cycle 1(1): loaded http://localhost:49222/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49222/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:49:19 INFO - PID 1673 | RSS: Main: 292716544 10:49:19 INFO - PID 1673 | 10:49:22 INFO - PID 1673 | Cycle 1(1): loaded http://localhost:49222/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49222/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:49:23 INFO - PID 1673 | RSS: Main: 292847616 10:49:23 INFO - PID 1673 | 10:49:25 INFO - PID 1673 | Cycle 1(1): loaded http://localhost:49222/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49222/tests/kraken/driver.html?testName=ai-astar) 10:49:25 INFO - PID 1673 | RSS: Main: 294637568 10:49:25 INFO - PID 1673 | 10:49:25 INFO - PID 1673 | __start_tp_report 10:49:25 INFO - PID 1673 | _x_x_mozilla_page_load 10:49:25 INFO - PID 1673 | _x_x_mozilla_page_load_details 10:49:25 INFO - PID 1673 | |i|pagename|runs| 10:49:25 INFO - PID 1673 | |0;ai-astar;103;113;127;165;125;114;113;116;113;115 10:49:25 INFO - PID 1673 | |1;audio-beat-detection;134;108;112;149;126;120;116;109;137;107 10:49:25 INFO - PID 1673 | |2;audio-dft;199;203;199;222;219;221;206;196;200;200 10:49:25 INFO - PID 1673 | |3;audio-fft;75;62;61;86;61;63;64;59;85;58 10:49:25 INFO - PID 1673 | |4;audio-oscillator;102;56;86;93;100;100;76;99;102;112 10:49:25 INFO - PID 1673 | |5;imaging-gaussian-blur;106;91;91;92;91;90;93;94;92;91 10:49:25 INFO - PID 1673 | |6;imaging-darkroom;98;99;98;98;98;104;154;98;98;98 10:49:25 INFO - PID 1673 | |7;imaging-desaturate;88;93;91;92;90;90;90;91;92;90 10:49:25 INFO - PID 1673 | |8;json-parse-financial;52;52;51;52;50;53;51;52;53;53 10:49:25 INFO - PID 1673 | |9;json-stringify-tinderbox;57;63;70;61;58;55;57;54;56;56 10:49:25 INFO - PID 1673 | |10;stanford-crypto-aes;86;91;89;89;89;90;87;89;129;91 10:49:25 INFO - PID 1673 | |11;stanford-crypto-ccm;134;139;140;146;142;139;151;133;141;156 10:49:25 INFO - PID 1673 | |12;stanford-crypto-pbkdf2;230;186;225;213;191;157;220;199;231;237 10:49:25 INFO - PID 1673 | |13;stanford-crypto-sha256-iterative;64;69;69;67;80;72;72;87;70;69 10:49:25 INFO - PID 1673 | __end_tp_report 10:49:25 INFO - PID 1673 | __start_cc_report 10:49:25 INFO - PID 1673 | _x_x_mozilla_cycle_collect,1194 10:49:25 INFO - PID 1673 | __end_cc_report 10:49:25 INFO - PID 1673 | __startTimestamp1496339365286__endTimestamp 10:49:25 INFO - PID 1673 | 10:49:25 INFO - PID 1673 | ------- Summary: start ------- 10:49:25 INFO - PID 1673 | Number of tests: 14 10:49:25 INFO - PID 1673 | 10:49:25 INFO - PID 1673 | [#0] ai-astar Cycles:10 Average:120.40 Median:115.50 stddev:17.03 (14.7%) stddev-sans-first:16.86 10:49:25 INFO - PID 1673 | Values: 103.0 113.0 127.0 165.0 125.0 114.0 113.0 116.0 113.0 115.0 10:49:25 INFO - PID 1673 | 10:49:25 INFO - PID 1673 | [#1] audio-beat-detection Cycles:10 Average:121.80 Median:123.00 stddev:14.31 (11.6%) stddev-sans-first:14.48 10:49:25 INFO - PID 1673 | Values: 134.0 108.0 112.0 149.0 126.0 120.0 116.0 109.0 137.0 107.0 10:49:25 INFO - PID 1673 | 10:49:25 INFO - PID 1673 | [#2] audio-dft Cycles:10 Average:206.50 Median:204.50 stddev:10.15 (5.0%) stddev-sans-first:10.39 10:49:25 INFO - PID 1673 | Values: 199.0 203.0 199.0 222.0 219.0 221.0 206.0 196.0 200.0 200.0 10:49:25 INFO - PID 1673 | 10:49:25 INFO - PID 1673 | [#3] audio-fft Cycles:10 Average:67.40 Median:63.50 stddev:10.62 (16.7%) stddev-sans-first:10.90 10:49:25 INFO - PID 1673 | Values: 75.0 62.0 61.0 86.0 61.0 63.0 64.0 59.0 85.0 58.0 10:49:25 INFO - PID 1673 | 10:49:25 INFO - PID 1673 | [#4] audio-oscillator Cycles:10 Average:92.60 Median:66.00 stddev:16.20 (24.5%) stddev-sans-first:16.82 10:49:25 INFO - PID 1673 | Values: 102.0 56.0 86.0 93.0 100.0 100.0 76.0 99.0 102.0 112.0 10:49:25 INFO - PID 1673 | 10:49:25 INFO - PID 1673 | [#5] imaging-gaussian-blur Cycles:10 Average:93.10 Median:91.50 stddev:4.68 (5.1%) stddev-sans-first:1.22 10:49:25 INFO - PID 1673 | Values: 106.0 91.0 91.0 92.0 91.0 90.0 93.0 94.0 92.0 91.0 10:49:25 INFO - PID 1673 | 10:49:25 INFO - PID 1673 | [#6] imaging-darkroom Cycles:10 Average:104.30 Median:98.00 stddev:17.56 (17.9%) stddev-sans-first:18.48 10:49:25 INFO - PID 1673 | Values: 98.0 99.0 98.0 98.0 98.0 104.0 154.0 98.0 98.0 98.0 10:49:25 INFO - PID 1673 | 10:49:25 INFO - PID 1673 | [#7] imaging-desaturate Cycles:10 Average:90.70 Median:91.00 stddev:1.42 (1.6%) stddev-sans-first:1.12 10:49:25 INFO - PID 1673 | Values: 88.0 93.0 91.0 92.0 90.0 90.0 90.0 91.0 92.0 90.0 10:49:25 INFO - PID 1673 | 10:49:25 INFO - PID 1673 | [#8] json-parse-financial Cycles:10 Average:51.90 Median:52.00 stddev:0.99 (1.9%) stddev-sans-first:1.05 10:49:25 INFO - PID 1673 | Values: 52.0 52.0 51.0 52.0 50.0 53.0 51.0 52.0 53.0 53.0 10:49:25 INFO - PID 1673 | 10:49:25 INFO - PID 1673 | [#9] json-stringify-tinderbox Cycles:10 Average:58.70 Median:57.50 stddev:4.81 (8.4%) stddev-sans-first:5.06 10:49:25 INFO - PID 1673 | Values: 57.0 63.0 70.0 61.0 58.0 55.0 57.0 54.0 56.0 56.0 10:49:25 INFO - PID 1673 | 10:49:25 INFO - PID 1673 | [#10] stanford-crypto-aes Cycles:10 Average:93.00 Median:89.00 stddev:12.75 (14.3%) stddev-sans-first:13.26 10:49:25 INFO - PID 1673 | Values: 86.0 91.0 89.0 89.0 89.0 90.0 87.0 89.0 129.0 91.0 10:49:25 INFO - PID 1673 | 10:49:25 INFO - PID 1673 | [#11] stanford-crypto-ccm Cycles:10 Average:142.10 Median:141.50 stddev:7.16 (5.1%) stddev-sans-first:6.96 10:49:25 INFO - PID 1673 | Values: 134.0 139.0 140.0 146.0 142.0 139.0 151.0 133.0 141.0 156.0 10:49:25 INFO - PID 1673 | 10:49:25 INFO - PID 1673 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:208.90 Median:222.50 stddev:25.30 (11.4%) stddev-sans-first:25.65 10:49:25 INFO - PID 1673 | Values: 230.0 186.0 225.0 213.0 191.0 157.0 220.0 199.0 231.0 237.0 10:49:25 INFO - PID 1673 | 10:49:25 INFO - PID 1673 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.90 Median:71.00 stddev:6.74 (9.5%) stddev-sans-first:6.51 10:49:25 INFO - PID 1673 | Values: 64.0 69.0 69.0 67.0 80.0 72.0 72.0 87.0 70.0 69.0 10:49:25 INFO - PID 1673 | -------- Summary: end -------- 10:49:25 INFO - PID 1673 | 10:49:26 INFO - TEST-INFO | 1673: exit 0 10:49:26 INFO - TEST-OK | kraken | took 90545ms 10:49:26 INFO - SUITE-END | took 1234s 10:49:26 INFO - Completed test suite (00:20:34) 10:49:26 INFO - javascript benchmark 10:49:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8153.018634174641, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3307.784993975392, 3595.5325807645004, 3635.872744453943, 3639.781613103214, 3656.689181419579, 6179.165812615295, 6186.072089186613, 6209.565330426872, 6228.252609686839, 6242.063690446435, 4837.830675926343, 6207.162033125526, 6243.594166379182, 6253.218347706536, 6301.117843501902, 5325.227841962913, 5494.395616482184, 5494.5054945054935, 5496.587755918302, 5596.132599447093, 5107.719075450848, 5192.480751924796, 5506.752196151183, 5620.0, 5623.915641265385, 5393.514583687487, 5420.214068960018, 5511.063119269734, 5524.447555244484, 5552.694601796899, 4513.842015529473, 5548.528375088082, 5549.0, 5560.277163968699, 5588.217649529029, 5437.673739575638, 5471.7264136793, 5492.670439773627, 5521.282233309684, 5541.418151094117, 6121.296050954153, 6155.0151975683675, 6189.690515474208, 6272.40412160844, 6273.686315684243, 6729.2261389940295, 6768.289329620368, 6772.966135169342, 6814.965925170342, 6816.829579260509, 6860.108185935796, 6894.758683446105, 6901.654917254167, 6906.723731050752, 6910.136232970879, 6189.504839612865, 6262.749490020348, 6312.210973628296, 6320.652364120017, 6394.424501794861, 6901.482388820858, 7000.0, 7016.087908571955, 7039.718411263594, 7061.152661680631, 6422.710978005907, 6544.770933017321, 6550.70521826519, 6610.7025183866845, 6617.172853393326, 6737.831554211184, 6856.691448884812, 6864.519483636098, 6877.277885822016, 6881.41507971828, 6603.80188594343, 6624.8343791405605, 6636.170478690164, 6652.201735791736, 6667.499937504706, 6534.215894092739, 6640.369164929324, 6650.733970641217, 6719.361660642231, 6797.592144471348, 5423.7830486780085, 5440.727963601804, 5445.455454454523, 5450.31871016123, 5484.2596249506605, 4746.359241502353, 4807.254875494304, 4830.758462076882, 4833.951660483421, 4846.8788280292565, 6268.874622507525, 6287.434130928238, 6293.150424692608, 6332.525060620472, 6382.968085159545, 6845.247022827485, 6895.413889819321, 6902.068220790229, 6914.274001229899, 6936.895946560806, 6278.968605156945, 6348.809535713936, 6355.936440635627, 6358.841028974312, 6372.076048972873, 4736.715797052188, 4968.403791545038, 5913.349531551526, 5994.790182343597, 6056.06131049688, 7035.929640703527, 7036.788896333118, 7036.9296307036275, 7065.788026359218, 7098.183708873339, 5718.914216286676, 6879.5184337095925, 6882.965585172042, 6884.483663725341, 6885.001674757233, 6848.589084654936, 6958.060661810793, 7042.859142817218, 7058.294170582901, 7083.539569927938, 6537.117489139096, 6637.30308317639, 6691.498137639599, 6728.764493242713, 6760.425363844129, 6850.554713943578, 6867.725290988305, 6872.793816185523, 6886.586804791728, 6906.033155358355, 5426.728663566885, 6477.902831457438, 6536.150300460909, 6573.375529324707, 6679.4990375721045, 5574.163875418558, 6589.868202636017, 6615.37153970372, 6636.568623039487, 6645.833854153685, 6465.612063276219, 6501.609903405811, 6543.672816359068, 6557.147570815954, 6558.245801732862, 6454.515911306765, 6468.579542329733, 6533.67331633407, 6664.566803157779, 6690.264070952288, 6374.075759014824, 6483.124778154889, 6493.935060649333, 6502.674866256573, 6508.674566271762], "value": 6151.91032872377, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [763.8930549723038, 784.4900814470593, 848.8556945319295, 1243.7699025680256, 1308.4504508106595, 39775.40336894945, 40972.975675608126, 40999.0, 41009.0, 41061.17877642449, 40806.387904181385, 41135.17729645405, 41171.794141029255, 41259.174816503655, 41349.586504134946, 8031.39764517662, 8205.384596155282, 8339.20777526134, 8563.571821408936, 8582.785430364229, 8548.40161188717, 8694.043655197924, 8696.652133914637, 8697.782555436133, 8700.12998700128, 8637.697680581181, 8649.308055355588, 8680.782980425509, 8702.086280940504, 8722.0, 8669.479831210116, 8698.652053917836, 8707.085755995657, 8717.825643487158, 8718.476891386474, 8410.285125764318, 8481.703140390118, 8484.151584841466, 8486.27866631337, 8486.915130848674, 37790.24419511622, 37883.0, 37911.431328530096, 37966.0, 38014.23971520554, 3489.982550087259, 3501.0547152268746, 3534.2224710563637, 3534.876279330211, 3545.2909418116224, 30626.54060189099, 30795.846020769975, 30826.383472330654, 30898.227544311347, 30972.8451357744, 3020.41101985113, 3089.2276930767307, 3096.14855914623, 3098.643655979569, 3112.813231206135, 214408.0, 216716.9164154185, 217328.99999999843, 273751.0, 275599.0, 49414.75292623514, 49643.50356496461, 49662.0, 49759.0, 49878.75060624674, 50141.74929125331, 51119.97760044778, 51754.0, 51929.480705192465, 51945.48054519406, 14475.348609312607, 14680.632984175267, 14681.853181468048, 14706.191159486118, 14728.968972172059, 11617.825732614017, 11735.88264117365, 11846.229995050295, 11857.0, 11866.0, 13861.653458663613, 13971.510997115052, 14009.509667161601, 14051.71896562063, 14157.575272741835, 6273.278572964076, 6299.6850157491945, 6317.6209427434505, 6356.2054743157105, 6358.109864618957, 882.9735107946772, 898.7618281155499, 977.4623956823718, 1006.4766321512918, 1036.657902892044, 21492.785072149392, 25182.0, 25229.116980905947, 25431.491370172494, 25432.058031005225, 1115.782422427635, 1122.9831552526718, 1125.960591379314, 1135.0579019413867, 1160.14729174057, 10641.0, 13002.934985325013, 13037.739245215043, 13067.477300907858, 13098.0, 342416.0, 344110.2794486011, 344364.2781786125, 345333.0, 345512.0, 57100.143497847566, 57355.0, 57522.42477575171, 57523.712381438665, 57551.71224143852, 1469.1552357394542, 1490.3144553505508, 1507.163524244055, 1520.673055293095, 1520.8631223189966, 24667.753322467262, 24803.87598061998, 26990.0, 29920.0, 30394.392112158075, 54290.0, 54945.0, 55030.44969550253, 55144.62138446571, 55261.618459537225, 295616.0, 296207.0, 298190.0, 298277.50861245557, 298357.0, 34922.82538587291, 36974.445383318736, 36974.8151259242, 37146.25707485889, 37204.44193337048, 45865.0, 45883.0, 46522.0, 46953.0, 47210.76394618005, 31135.84432077825, 31518.896838610537, 31974.0, 32112.197195069377, 32472.512912306807, 27471.17586472409, 28253.293667658472, 31065.8446707765, 31664.208394790316, 32057.87797427079, 38172.80913595414, 38330.80834595809, 38381.424278635284, 38423.80788096153, 38479.61520384761, 29723.55414668825, 30771.0, 31301.373972520876, 32502.0, 32912.506312404854, 22539.5492090154, 23799.52400952006, 24388.0, 24597.0, 25254.989800407777], "value": 18111.423917120148, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [408.70573187305143, 413.59261127789125, 427.0945595337884, 432.96752743544243, 457.66590389016017, 14468.421263149488, 15182.924085379585, 21614.99999999998, 22278.331650050503, 22363.55272894541, 22577.54844903101, 23342.88328558355, 23355.065797368086, 23399.415014624643, 23464.765352346472, 6013.75944962201, 6188.504919606443, 6191.102290167923, 6194.938050619504, 6199.504039676815, 6033.215681961339, 6115.755369785204, 6146.07808828677, 6150.200473938382, 6160.691965401712, 5877.67672777997, 5977.940220597782, 5989.490893274077, 6057.862586306389, 6088.96955515224, 5975.073863551156, 5978.790742324019, 6024.548158888101, 6035.275766907977, 6049.939500604982, 5362.088444964365, 5367.892642147174, 5374.193870919355, 5374.48942350476, 5384.3538775346815, 22127.778722212734, 27462.17613471599, 27764.722352776414, 27795.722042779515, 27821.0, 2111.8627289226306, 2161.373201771484, 2212.5353675727956, 2236.3402796175005, 2237.105157936822, 18520.073996300132, 18641.72037419426, 18683.906580467148, 18786.90606546972, 18801.623967520572, 2146.302451703187, 2187.442202238435, 2215.3796936857543, 2220.222921977311, 2223.144089525528, 186076.06961965104, 187861.06069469565, 187953.99999999863, 190219.0, 190591.0, 10821.24251302417, 12831.615051548468, 13039.217646941213, 13092.279924604049, 13517.32413379327, 13469.0, 16647.583810404594, 16654.417095401845, 16743.74884376711, 16816.32734690623, 8970.551472426352, 9019.458832470073, 9183.448993060438, 9234.399764015317, 9321.021292764297, 7273.89089163663, 7319.377852882458, 8907.910920890838, 8920.598573064228, 9027.638894444148, 7539.71824789787, 8127.552984585786, 8182.4681395709085, 8194.631241594143, 8218.753437396888, 1987.1753222412826, 2121.8939053047284, 2126.245182960027, 2221.6112180368373, 2234.229190929127, 899.6356475627381, 924.2467389078014, 961.4183419031525, 999.2256001598673, 1000.4393146691185, 18243.361482348053, 19570.315038973567, 20256.088476018616, 20838.791612083685, 21195.78804211969, 791.6872835230051, 971.4948226921961, 983.5524836199512, 999.8551658351147, 1002.3935519011039, 8344.539705551504, 10274.948625256826, 10755.83866242007, 10884.719566602895, 10896.291741036806, 560861.0, 569601.0, 584088.0, 590478.0, 593838.0, 152837.23581382245, 161973.19013404858, 163590.0, 164143.0, 165602.1719891393, 1202.512982242176, 1214.732758793064, 1258.2827788160844, 1259.4836117191908, 1267.1889990406148, 21408.571828563654, 22067.0, 22452.887735561217, 22672.886635566716, 22722.43193920165, 68540.6572967132, 68619.0, 68927.65536172286, 69067.30932690609, 69831.65084174546, 95593.0, 95749.042509574, 95912.0, 96031.0, 96168.51915740376, 10078.596856125672, 10165.33925294883, 10234.283600147919, 10238.692839214538, 10253.179745620482, 12766.234025958473, 13119.540816071774, 18066.1870215838, 18097.276108955495, 18245.178966946252, 13958.930205348908, 14476.0, 14623.92688036553, 14681.70636587241, 14722.63193420173, 12908.290044047668, 13291.335433228493, 13307.80038299407, 13370.726976413838, 13399.598012059654, 13013.349332533524, 14720.337584808924, 15106.697866042838, 15175.544733658007, 15245.771313430529, 9998.900010999796, 10018.448985305587, 10089.344192627455, 10113.988601140121, 10124.443155626512, 14509.201993890438, 14582.343794529485, 14620.707585848437, 14686.118832870063, 14761.630959226106], "value": 11049.586030599392, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1236.2891337480944, 1332.8000799880017, 1405.3043743347046, 1417.8015077889095, 1419.6663784010761, 11688.064954803616, 11863.406829658516, 12334.506619735212, 12338.938305308484, 12365.381730913452, 12083.818742718844, 12213.633590992262, 12304.63086107416, 12324.198927069734, 12324.5070197192, 2429.6758266744578, 2489.327881471997, 2538.6826646669165, 2542.0721436675667, 2545.363659085229, 2130.7123538322285, 2230.1971290335546, 2311.4221444638843, 2511.3972646564785, 2543.567593509108, 2576.6135079738, 2603.4923189977962, 2613.202973093206, 2615.712271650117, 2622.803289753276, 2528.1025236041214, 2553.0553695132735, 2557.8721063946728, 2561.513312470634, 2568.370749166457, 2516.3331717094984, 2529.4182338062164, 2531.354504601315, 2531.8227724059325, 2539.7206307306183, 11847.0, 12076.637700868989, 12126.333051682153, 12154.33151176685, 12168.81746773799, 5864.0, 5989.802039592056, 6770.187577490733, 6826.283240259801, 6832.111825462708, 4084.8978775530554, 4109.301418758818, 4339.153864996327, 4346.0, 4359.17175736609, 1234.9012079033655, 1272.198514935594, 1286.5561381323428, 1292.366740297257, 1293.0948336164722, 16749.162541872858, 16879.0, 16902.830971690248, 16919.74620380683, 16926.83073169277, 5185.637005409585, 5542.86142846424, 5611.0, 5676.0, 5796.753817862011, 12271.079669024859, 12450.25298482094, 12466.189697669623, 12479.438425270884, 12491.0, 6369.108324834527, 6501.187351581052, 6585.176852893388, 6604.273529911706, 6611.173603299588, 6010.609310394811, 6207.751689932443, 6221.129041934133, 6232.220972378453, 6250.1874756282305, 4413.0, 4527.818887244473, 4541.863744087616, 4554.72467709042, 4555.476120246214, 1171.2679575265458, 1209.618970024457, 1288.3429450980068, 1296.9092163548462, 1321.7752981993085, 755.3768141283354, 775.6005657086605, 793.9325157361574, 797.9960100199462, 803.7669075968021, 6805.557638753465, 7033.683484243222, 7073.540219885691, 7111.928880711127, 7312.5246858954, 958.1855422890487, 962.8122516109431, 963.9855402168973, 981.5730157381562, 985.6895078050392, 4253.97904502917, 4379.802908869108, 4563.817447302137, 4604.7927843247135, 4611.100835337077, 14714.632134196516, 15311.310991005432, 15410.0, 15449.0, 15508.767368489482, 14960.251987400587, 15085.54743357701, 15311.770323445156, 15497.302621382065, 15522.611934701497, 8319.459235149696, 8664.8700269496, 8722.912770872337, 8761.824763504694, 8771.254443372385, 6072.969635151972, 6654.86867232562, 6937.653117344214, 7104.360607545345, 7108.857822843411, 13813.309334533033, 13880.652983675489, 14030.929845350707, 14185.361658725176, 14249.643758905695, 13285.335733213495, 14338.283085845458, 14356.138631682132, 14398.208098554262, 14460.566183014527, 9608.615655373707, 9758.609655613696, 9888.060634239735, 9890.604375824887, 9910.554025069034, 10893.291936024134, 10994.670159895217, 11003.559857605605, 11096.722581935515, 11134.109271258441, 9119.635214591342, 9228.215601673934, 9250.861237081584, 9413.717588472357, 9453.33826632129, 9059.320550958573, 9065.592048357708, 9083.818323633623, 9176.0, 9186.816263674822, 8298.834023319621, 8396.496210227406, 8441.915580844114, 8444.36667249971, 8456.027556831043, 6041.18444010053, 6051.183090282755, 6137.508999279958, 6194.101855231056, 6331.27190373113, 6088.208532890873, 6161.137440758387, 6298.716557755004, 6331.303556608677, 6394.424501794861], "value": 5497.5982847491805, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [307.24877674086855, 362.7098321342925, 400.71749416661254, 404.4964019795355, 404.6883899397463, 5298.549623282026, 6469.320721324264, 6502.349765023501, 6514.543981921267, 6522.739090436383, 5579.898774400823, 6106.633601983873, 6154.692265386724, 6299.590526615767, 6351.555391122612, 4531.614812740921, 4585.747783871886, 4610.354550362952, 4614.930776038345, 4652.371929789469, 4610.216263235241, 4611.2852507861335, 4612.884677883047, 4631.39791827062, 4635.768211589424, 3935.9016024599327, 4578.267477203648, 4580.725156490605, 4594.678372513926, 4685.578297953183, 4576.679632425731, 4578.862634120948, 4579.954200458003, 4591.8979444932975, 4605.194091034055, 3120.7659425542947, 3878.3406820840523, 3963.6829053675638, 3970.7021973352116, 3989.4614227079264, 6190.783322583733, 6192.969035154841, 6205.534584906105, 6226.813195604139, 6226.866536461582, 5528.806491772769, 5532.419095994903, 5532.612717109804, 5534.391216966131, 5557.749901254453, 6786.405194779223, 6809.727610895558, 6815.897761533581, 6819.24988251292, 6841.2132604750095, 4120.690948178869, 4249.915001699979, 4514.616257618107, 4530.29780384041, 4545.11370282795, 4989.625778066659, 6174.444300012976, 6756.952672335796, 7218.45861560385, 7322.231165727575, 3577.874774382884, 4552.453705555355, 4594.448666160015, 4612.0, 4624.606908412823, 3717.5353080864893, 4174.874753757392, 4667.95332046682, 4693.084848454587, 4706.811727530929, 4791.568758811654, 5266.894662106736, 5465.672059676433, 5468.0977638689965, 5487.64330318528, 6703.028060931138, 6767.868121541698, 6778.32256258775, 6783.152105986752, 6819.430981242579, 1383.9308034598432, 1434.4579576954816, 1591.3793620488018, 1598.3846219205689, 1599.9760003599956, 888.684516996457, 1034.3225187502198, 1065.9360438373722, 1066.3069005146717, 1069.4652673663168, 6426.518011149183, 6458.0, 6458.418742313214, 6462.773802916875, 6479.157709497735, 6678.365555272241, 7060.011598376232, 7074.92925070753, 7088.468364872655, 7107.39587135089, 5126.154184559506, 6033.577649564576, 6050.909236361458, 6433.973298410986, 6473.546851720429, 3394.9151271218416, 3654.538184726131, 3690.2988432197794, 3716.832742526593, 3718.6095459976855, 5704.973104841169, 6624.0, 7002.439804815603, 7299.160596531361, 7317.853642927112, 7238.98654188414, 7262.782116536512, 7289.343959043712, 7297.525660832029, 7326.9267307326245, 5358.866028349166, 5560.388357280696, 6049.425304596057, 6526.955687090042, 7323.523970941872, 6987.965060174666, 7080.575165490087, 7081.433485321265, 7098.0480367899245, 7101.467389945671, 5812.709364531672, 6919.4710697543605, 6970.198427180939, 6986.685599147949, 7026.964865175846, 6736.427403670743, 7179.0, 7235.493515453868, 7265.9273407265255, 7277.3086556779135, 4180.310248808913, 4278.251306021371, 4360.9345859812765, 4551.135284295973, 4601.608863246662, 5873.883962047197, 6180.258368995749, 6428.19647544057, 7056.576605403692, 7081.291870812877, 5858.004139296245, 6202.193714817226, 6313.589616674902, 6788.59268443895, 6828.0, 6165.441341843085, 6220.440160385587, 6691.76578819739, 6765.154355705537, 6786.68837980663, 6290.4144637556155, 6570.507211959027, 6654.234763002317, 6665.533412661067, 6671.766488172891, 5678.602497825113, 5814.651120932757, 6421.422072013541, 6773.62745049027, 6777.830554236183, 5541.5843811715085, 6391.456726178327, 6491.4806815455595, 6602.7689030883685, 6613.470922326299], "value": 4866.87530781107, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [815.3069890592994, 828.382854773194, 849.9575021248936, 866.5277423804026, 874.0, 14214.71570568588, 14765.335559899804, 16931.576710582227, 17286.827131728678, 17428.651426971453, 17271.39550115746, 17986.82013179868, 18057.81942180578, 18065.81934180658, 18100.185491652875, 961.0725649747992, 973.522973742868, 975.4050029482011, 981.7398389426808, 982.4891056650538, 1027.9794404111913, 1029.6344797596857, 1029.6756521695643, 1031.3914790273736, 1031.6595523477235, 942.6370847223834, 1056.0653821368105, 1059.502034043998, 1063.2504084620364, 1064.249703958711, 1049.800537897797, 1055.8310670292756, 1057.7620035491952, 1058.8252938265216, 1059.1632610237903, 776.4526009163526, 777.2577188784697, 778.2217782217782, 778.4434129597365, 778.8014056415634, 17030.574235644082, 17550.38573649916, 17675.027873466955, 17847.821521784746, 18225.908870455696, 17831.286748530045, 17894.28422863084, 17902.820971790246, 18328.266869325213, 18344.908275458536, 14738.852611473962, 14910.850891491054, 15005.624859378493, 15032.17323047232, 15034.0, 3576.6423357664285, 3627.818609069536, 3645.5989841117457, 3671.596124426311, 3691.8338674759702, 129865.35067324602, 130101.0, 130692.99999999905, 131318.0, 131529.0, 13549.932250338685, 13766.518171863936, 13797.172169669651, 13889.652758681113, 13893.513727019506, 26254.868725656248, 26807.051224365303, 27224.183274501796, 27248.727512724618, 27251.182464526097, 6748.426383757435, 7819.0617125945255, 7911.446198766032, 7979.8404031919035, 8045.0748163960725, 3992.261431635157, 4087.2642924273323, 4094.672426205956, 4097.078157414618, 4100.5489396166395, 4268.210381079511, 4353.36876152956, 4353.434053573015, 4372.344148377769, 4372.606465418127, 934.7709811096189, 947.8625599288065, 953.6471505542994, 954.4130359828655, 955.9091886270793, 633.2938773267773, 656.0913135307538, 662.6686656671665, 667.6695035957232, 672.7712577723597, 11263.0, 12149.420575325152, 12391.690207744878, 12444.191127576678, 12642.873571264354, 635.237714742311, 637.4549759955264, 643.7103303513437, 647.7150053976235, 666.2504682232488, 4962.379702537183, 5602.719864006865, 5619.353774315924, 5694.572907031989, 5849.356570777211, 125595.74404256023, 134461.32769336092, 135907.0, 137309.0, 140107.29946350204, 119480.61038779176, 120691.39654301848, 121811.0, 125844.2618057347, 126926.36536817442, 82117.76823347654, 103408.96591033993, 104178.47910760398, 104387.39031524272, 107582.0, 12411.813822792485, 12954.676133096747, 13007.219566826021, 13025.413856376676, 13048.608541743763, 40840.978975525846, 45059.77470112628, 45124.548754512034, 45220.09559808851, 45532.31701524414, 71540.56918861698, 73680.89478657718, 83906.16093838983, 85256.14743852481, 85980.57009714912, 17972.460826175236, 18075.909620451814, 18164.364247251284, 18174.0, 18344.816551834312, 18297.085145742927, 19142.8085719141, 19562.60874782468, 19730.40808775739, 19845.0, 15304.617384565476, 18223.45329640113, 18268.26926922908, 18640.533986650444, 18884.33904813325, 16937.91531042337, 18387.356442524448, 18434.81565184331, 18469.72295415543, 18657.253709851455, 17054.317827287265, 17290.481285561455, 18229.54426139304, 18343.63312733711, 18355.54111147232, 10869.619364062546, 12009.339486327986, 12458.563950261698, 12636.32311425861, 12705.745885082431, 11544.769104618028, 12046.457909393923, 12166.695832603902, 14401.567952961428, 14521.636959076108], "value": 8915.538523241816, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1523.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 127.0, 165.0, 125.0, 114.0, 113.0, 116.0, 113.0, 115.0], "value": 120.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 108.0, 112.0, 149.0, 126.0, 120.0, 116.0, 109.0, 137.0, 107.0], "value": 121.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 203.0, 199.0, 222.0, 219.0, 221.0, 206.0, 196.0, 200.0, 200.0], "value": 206.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 62.0, 61.0, 86.0, 61.0, 63.0, 64.0, 59.0, 85.0, 58.0], "value": 67.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 56.0, 86.0, 93.0, 100.0, 100.0, 76.0, 99.0, 102.0, 112.0], "value": 92.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 91.0, 91.0, 92.0, 91.0, 90.0, 93.0, 94.0, 92.0, 91.0], "value": 93.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 99.0, 98.0, 98.0, 98.0, 104.0, 154.0, 98.0, 98.0, 98.0], "value": 104.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 93.0, 91.0, 92.0, 90.0, 90.0, 90.0, 91.0, 92.0, 90.0], "value": 90.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 51.0, 52.0, 50.0, 53.0, 51.0, 52.0, 53.0, 53.0], "value": 51.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 63.0, 70.0, 61.0, 58.0, 55.0, 57.0, 54.0, 56.0, 56.0], "value": 58.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 91.0, 89.0, 89.0, 89.0, 90.0, 87.0, 89.0, 129.0, 91.0], "value": 93.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 139.0, 140.0, 146.0, 142.0, 139.0, 151.0, 133.0, 141.0, 156.0], "value": 142.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [230.0, 186.0, 225.0, 213.0, 191.0, 157.0, 220.0, 199.0, 231.0, 237.0], "value": 208.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 69.0, 69.0, 67.0, 80.0, 72.0, 72.0, 87.0, 70.0, 69.0], "value": 71.9, "unit": "score"}]}]} 10:49:26 INFO - Return code: 0 10:49:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:49:26 INFO - # TBPL SUCCESS # 10:49:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:49:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:49:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:49:26 INFO - 2017-06-01 10:49:26.675 screenresolution[1681:11306] starting screenresolution argv=screenresolution get 10:49:26 INFO - 2017-06-01 10:49:26.677 screenresolution[1681:11306] Display 0: 1600x1200x32@60 10:49:26 INFO - 2017-06-01 10:49:26.683 screenresolution[1682:11309] starting screenresolution argv=screenresolution list 10:49:26 INFO - Available Modes on Display 0 10:49:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:49:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:49:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:49:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:49:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:49:26 INFO - Intel Iris: 10:49:26 INFO - Chipset Model: Intel Iris 10:49:26 INFO - Type: GPU 10:49:26 INFO - Bus: Built-In 10:49:26 INFO - VRAM (Dynamic, Max): 1536 MB 10:49:26 INFO - Vendor: Intel (0x8086) 10:49:26 INFO - Device ID: 0x0a2e 10:49:26 INFO - Revision ID: 0x0009 10:49:26 INFO - Displays: 10:49:26 INFO - Display: 10:49:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:49:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:49:26 INFO - Display Serial Number: 1600x1200 60 10:49:26 INFO - Main Display: Yes 10:49:26 INFO - Mirror: Off 10:49:26 INFO - Online: Yes 10:49:26 INFO - Rotation: Supported 10:49:26 INFO - Return code: 0 10:49:26 INFO - Running post-action listener: _resource_record_post_action 10:49:26 INFO - [mozharness: 2017-06-01 17:49:26.917893Z] Finished run-tests step (success) 10:49:26 INFO - Running post-run listener: _resource_record_post_run 10:49:26 INFO - Total resource usage - Wall time: 1257s; CPU: 53.0%; Read bytes: 40752640; Write bytes: 571224576; Read time: 283; Write time: 1744 10:49:26 INFO - TinderboxPrint: CPU usage
53.4% 10:49:26 INFO - TinderboxPrint: I/O read bytes / time
40,752,640 / 283 10:49:26 INFO - TinderboxPrint: I/O write bytes / time
571,224,576 / 1,744 10:49:26 INFO - TinderboxPrint: CPU idle
2,343.9 (46.6%) 10:49:26 INFO - TinderboxPrint: CPU system
1,018.6 (20.3%) 10:49:26 INFO - TinderboxPrint: CPU user
1,667.1 (33.1%) 10:49:26 INFO - TinderboxPrint: Swap in / out
285,810,688 / 0 10:49:26 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 239450624; Write bytes: 233453056; Read time: 18115; Write time: 485 10:49:26 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 10:49:26 INFO - run-tests - Wall time: 1236s; CPU: 53.0%; Read bytes: 38540800; Write bytes: 321354752; Read time: 262; Write time: 1212 10:49:27 INFO - Running post-run listener: _upload_blobber_files 10:49:27 INFO - Blob upload gear active. 10:49:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:49:27 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 10:49:27 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'] 10:49:27 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 10:49:27 INFO - (blobuploader) - INFO - Open directory for files ... 10:49:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:49:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:49:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:49:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:49:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:49:28 INFO - (blobuploader) - INFO - Done attempting. 10:49:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:49:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:49:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:49:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:49:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:49:29 INFO - (blobuploader) - INFO - Done attempting. 10:49:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:49:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:49:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:49:30 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:49:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:49:30 INFO - (blobuploader) - INFO - Done attempting. 10:49:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:49:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:49:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:49:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:49:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:49:33 INFO - (blobuploader) - INFO - Done attempting. 10:49:33 INFO - (blobuploader) - INFO - Iteration through files over. 10:49:33 INFO - Return code: 0 10:49:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:49:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:49:33 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d8c6e1a9eb8955607f1032155385211109b9b287859e118c2c814bb331c524d9664e5e51b85ee25f7a0215d5a2adf2a848af79b51a54f47a5d7960edf1de480f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4cc1c73722b2db9bdc310415f92b515b902d07598e91b59f1ce2e639cec7b1266c93434e271befc396d4daeac4c62e58e26e55dbe740c5d55c8c182c427cf249", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/76c62758cec775ff225c3614165d1b4c39c580bb635690689ff6161df404a894a0acda8cc2b313b2ec808f1bd941d24e09cc2158398126797154cc8ffefe9482", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/00c9030c86e81368dda9529ae420e53c5b04b209fa9ec9e061aac813e8fb5e5dbb8cf3b5ec14a6738dbbf06ec95950c4eb4f7f3aede022ce7e550daddab60afb"} 10:49:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:49:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:49:33 INFO - Contents: 10:49:33 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d8c6e1a9eb8955607f1032155385211109b9b287859e118c2c814bb331c524d9664e5e51b85ee25f7a0215d5a2adf2a848af79b51a54f47a5d7960edf1de480f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4cc1c73722b2db9bdc310415f92b515b902d07598e91b59f1ce2e639cec7b1266c93434e271befc396d4daeac4c62e58e26e55dbe740c5d55c8c182c427cf249", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/76c62758cec775ff225c3614165d1b4c39c580bb635690689ff6161df404a894a0acda8cc2b313b2ec808f1bd941d24e09cc2158398126797154cc8ffefe9482", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/00c9030c86e81368dda9529ae420e53c5b04b209fa9ec9e061aac813e8fb5e5dbb8cf3b5ec14a6738dbbf06ec95950c4eb4f7f3aede022ce7e550daddab60afb"} 10:49:33 INFO - Running post-run listener: copy_logs_to_upload_dir 10:49:33 INFO - Copying logs to upload dir... 10:49:33 INFO - mkdir: /builds/slave/test/build/upload/logs 10:49:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1339.529629 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 22 mins, 19 secs) (at 2017-06-01 10:49:33.198455) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-01 10:49:33.201757) ========= 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.XJRYgieuF5/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.RI6Hac51Az/Listeners TMPDIR=/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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/d8c6e1a9eb8955607f1032155385211109b9b287859e118c2c814bb331c524d9664e5e51b85ee25f7a0215d5a2adf2a848af79b51a54f47a5d7960edf1de480f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4cc1c73722b2db9bdc310415f92b515b902d07598e91b59f1ce2e639cec7b1266c93434e271befc396d4daeac4c62e58e26e55dbe740c5d55c8c182c427cf249", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/76c62758cec775ff225c3614165d1b4c39c580bb635690689ff6161df404a894a0acda8cc2b313b2ec808f1bd941d24e09cc2158398126797154cc8ffefe9482", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/00c9030c86e81368dda9529ae420e53c5b04b209fa9ec9e061aac813e8fb5e5dbb8cf3b5ec14a6738dbbf06ec95950c4eb4f7f3aede022ce7e550daddab60afb"} build_url:https://queue.taskcluster.net/v1/task/B4veWz6LTiavgUX6DJZ8eA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011168 build_url: 'https://queue.taskcluster.net/v1/task/B4veWz6LTiavgUX6DJZ8eA/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/d8c6e1a9eb8955607f1032155385211109b9b287859e118c2c814bb331c524d9664e5e51b85ee25f7a0215d5a2adf2a848af79b51a54f47a5d7960edf1de480f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4cc1c73722b2db9bdc310415f92b515b902d07598e91b59f1ce2e639cec7b1266c93434e271befc396d4daeac4c62e58e26e55dbe740c5d55c8c182c427cf249", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/76c62758cec775ff225c3614165d1b4c39c580bb635690689ff6161df404a894a0acda8cc2b313b2ec808f1bd941d24e09cc2158398126797154cc8ffefe9482", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/00c9030c86e81368dda9529ae420e53c5b04b209fa9ec9e061aac813e8fb5e5dbb8cf3b5ec14a6738dbbf06ec95950c4eb4f7f3aede022ce7e550daddab60afb"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-01 10:49:33.235605) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 10:49:33.235956) ========= 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.XJRYgieuF5/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.RI6Hac51Az/Listeners TMPDIR=/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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.005116 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 10:49:33.284497) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-01 10:49:33.284817) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-01 10:49:33.285165) ========= ========= Total master_lag: 0.19 =========