builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s-pgo slave: talos-linux64-ix-072 starttime: 1504808988.97 results: success (0) revision: 3c96d611ebd67fc219d22bcb476a72412c76f6c7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-07 11:29:48.974348) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-07 11:29:48.974783) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-07 11:29:48.975081) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-07 11:29:48.992679) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 11:29:48.993201) ========= 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: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=199fb4c72b90437b990b419b000001c5-1504808988.182962-1302296783 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-07 11:29:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2017-09-07 11:29:49 (220 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.151112 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 11:29:49.161613) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 11:29:49.161997) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=199fb4c72b90437b990b419b000001c5-1504808988.182962-1302296783 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017650 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 11:29:49.211763) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 11:29:49.212121) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3c96d611ebd67fc219d22bcb476a72412c76f6c7 --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 3c96d611ebd67fc219d22bcb476a72412c76f6c7 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=199fb4c72b90437b990b419b000001c5-1504808988.182962-1302296783 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-07 11:29:49,272 truncating revision to first 12 chars 2017-09-07 11:29:49,272 Setting DEBUG logging. 2017-09-07 11:29:49,272 attempt 1/10 2017-09-07 11:29:49,272 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3c96d611ebd6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-07 11:29:49,672 unpacking tar archive at: mozilla-central-3c96d611ebd6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.674916 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 11:29:49.903247) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-07 11:29:49.903617) ========= script_repo_revision: 3c96d611ebd67fc219d22bcb476a72412c76f6c7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-07 11:29:49.904081) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-07 11:29:49.904367) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-07 11:29:49.916853) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2017-09-07 11:29:49.917231) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_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', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-stylo-disabled-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=199fb4c72b90437b990b419b000001c5-1504808988.182962-1302296783 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:29:50 INFO - MultiFileLogger online at 20170907 11:29:50 in /builds/slave/test 11:29:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 11:29:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:29:50 INFO - {'append_to_log': False, 11:29:50 INFO - 'base_work_dir': '/builds/slave/test', 11:29:50 INFO - 'blob_upload_branch': 'Firefox', 11:29:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:29:50 INFO - 'branch': 'Firefox', 11:29:50 INFO - 'buildbot_json_path': 'buildprops.json', 11:29:50 INFO - 'code_coverage': False, 11:29:50 INFO - 'config_files': ('talos/linux_config.py',), 11:29:50 INFO - 'default_actions': ('clobber', 11:29:50 INFO - 'read-buildbot-config', 11:29:50 INFO - 'download-and-extract', 11:29:50 INFO - 'populate-webroot', 11:29:50 INFO - 'create-virtualenv', 11:29:50 INFO - 'install', 11:29:50 INFO - 'setup-mitmproxy', 11:29:50 INFO - 'run-tests'), 11:29:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:29:50 INFO - 'disable_ccov_upload': False, 11:29:50 INFO - 'disable_stylo': False, 11:29:50 INFO - 'download_minidump_stackwalk': True, 11:29:50 INFO - 'download_symbols': 'ondemand', 11:29:50 INFO - 'enable_stylo': False, 11:29:50 INFO - 'enable_webrender': False, 11:29:50 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 11:29:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:29:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:29:50 INFO - 'gecko_profile': False, 11:29:50 INFO - 'gecko_profile_interval': 0, 11:29:50 INFO - 'installer_path': 'installer.exe', 11:29:50 INFO - 'log_level': 'info', 11:29:50 INFO - 'log_name': 'talos', 11:29:50 INFO - 'log_to_console': True, 11:29:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:29:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:29:50 INFO - 'opt_config_files': (), 11:29:50 INFO - 'pip_index': False, 11:29:50 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 11:29:50 INFO - 'system_bits': '32', 11:29:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:29:50 INFO - 'title': 'talos-linux64-ix-072', 11:29:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:29:50 INFO - 'use_talos_json': True, 11:29:50 INFO - 'verify': 'False', 11:29:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:29:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:29:50 INFO - 'work_dir': 'build'} 11:29:50 INFO - [mozharness: 2017-09-07 18:29:50.119948Z] Running clobber step. 11:29:50 INFO - Running pre-action listener: _resource_record_pre_action 11:29:50 INFO - Running main action method: clobber 11:29:50 INFO - rmtree: /builds/slave/test/build 11:29:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:29:51 INFO - Running post-action listener: _resource_record_post_action 11:29:51 INFO - [mozharness: 2017-09-07 18:29:51.778325Z] Finished clobber step (success) 11:29:51 INFO - [mozharness: 2017-09-07 18:29:51.778423Z] Running read-buildbot-config step. 11:29:51 INFO - Running pre-action listener: _resource_record_pre_action 11:29:51 INFO - Running main action method: read_buildbot_config 11:29:51 INFO - Using buildbot properties: 11:29:51 INFO - { 11:29:51 INFO - "project": "", 11:29:51 INFO - "product": "firefox", 11:29:51 INFO - "who": "ffxbld@noreply.mozilla.org", 11:29:51 INFO - "installer_path": "public/build/target.tar.bz2", 11:29:51 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 11:29:51 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:29:51 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-stylo-disabled-e10s", 11:29:51 INFO - "stage_platform": "linux64-pgo", 11:29:51 INFO - "basedir": "/builds/slave/test", 11:29:51 INFO - "buildnumber": 4, 11:29:51 INFO - "platform": "ubuntu64_hw", 11:29:51 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:29:51 INFO - "slavebuilddir": "test", 11:29:51 INFO - "taskId": "WcKmm1i0SheKTpv0oCSdNQ", 11:29:51 INFO - "branch": "mozilla-central", 11:29:51 INFO - "script_repo_revision": "production", 11:29:51 INFO - "revision": "3c96d611ebd67fc219d22bcb476a72412c76f6c7", 11:29:51 INFO - "slavename": "talos-linux64-ix-072", 11:29:51 INFO - "repo_path": "mozilla-central" 11:29:51 INFO - } 11:29:51 INFO - Finding installer, test and symbols from parent task. 11:29:51 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WcKmm1i0SheKTpv0oCSdNQ'}, attempt #1 11:29:52 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WcKmm1i0SheKTpv0oCSdNQ'}, attempt #1 11:29:52 INFO - Task dependencies: IGNMaOSuRLejLW-8IRhPzg 11:29:52 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IGNMaOSuRLejLW-8IRhPzg'}, attempt #1 11:29:53 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/IGNMaOSuRLejLW-8IRhPzg/artifacts/public/build/target.tar.bz2 11:29:53 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/IGNMaOSuRLejLW-8IRhPzg/artifacts/public/build/target.test_packages.json 11:29:53 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/IGNMaOSuRLejLW-8IRhPzg/artifacts/public/build/target.crashreporter-symbols.zip 11:29:53 INFO - Running post-action listener: _resource_record_post_action 11:29:53 INFO - [mozharness: 2017-09-07 18:29:53.297559Z] Finished read-buildbot-config step (success) 11:29:53 INFO - [mozharness: 2017-09-07 18:29:53.297775Z] Running download-and-extract step. 11:29:53 INFO - Running pre-action listener: _resource_record_pre_action 11:29:53 INFO - Running main action method: download_and_extract 11:29:53 INFO - mkdir: /builds/slave/test/build/tests 11:29:53 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')]} 11:29:53 INFO - trying https://queue.taskcluster.net/v1/task/IGNMaOSuRLejLW-8IRhPzg/artifacts/public/build/target.test_packages.json 11:29:53 INFO - Downloading https://queue.taskcluster.net/v1/task/IGNMaOSuRLejLW-8IRhPzg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:29:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IGNMaOSuRLejLW-8IRhPzg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:29:53 INFO - Downloaded 989 bytes. 11:29:53 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:29:53 INFO - Using the following test package requirements: 11:29:53 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:29:53 INFO - u'common': [u'target.common.tests.zip'], 11:29:53 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:29:53 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:29:53 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:29:53 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:29:53 INFO - u'mozbase': [u'target.common.tests.zip'], 11:29:53 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:29:53 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:29:53 INFO - u'web-platform': [u'target.common.tests.zip', 11:29:53 INFO - u'target.web-platform.tests.tar.gz'], 11:29:53 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:29:53 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 11:29:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IGNMaOSuRLejLW-8IRhPzg/artifacts/public/build/target.common.tests.zip 11:29:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IGNMaOSuRLejLW-8IRhPzg/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:29:53 INFO - Fetch https://queue.taskcluster.net/v1/task/IGNMaOSuRLejLW-8IRhPzg/artifacts/public/build/target.common.tests.zip into memory 11:29:54 INFO - Content-Length response header: 55690701 11:29:54 INFO - Bytes received: 55690701 11:30:05 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 11:30:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IGNMaOSuRLejLW-8IRhPzg/artifacts/public/build/target.common.tests.zip 11:30:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IGNMaOSuRLejLW-8IRhPzg/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:30:05 INFO - Fetch https://queue.taskcluster.net/v1/task/IGNMaOSuRLejLW-8IRhPzg/artifacts/public/build/target.common.tests.zip into memory 11:30:07 INFO - Content-Length response header: 55690701 11:30:07 INFO - Bytes received: 55690701 11:30:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IGNMaOSuRLejLW-8IRhPzg/artifacts/public/build/target.talos.tests.zip 11:30:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IGNMaOSuRLejLW-8IRhPzg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:30:18 INFO - Fetch https://queue.taskcluster.net/v1/task/IGNMaOSuRLejLW-8IRhPzg/artifacts/public/build/target.talos.tests.zip into memory 11:30:19 INFO - Content-Length response header: 14496665 11:30:19 INFO - Bytes received: 14496665 11:30:19 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')]} 11:30:19 INFO - trying https://queue.taskcluster.net/v1/task/IGNMaOSuRLejLW-8IRhPzg/artifacts/public/build/target.tar.bz2 11:30:19 INFO - Downloading https://queue.taskcluster.net/v1/task/IGNMaOSuRLejLW-8IRhPzg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:30:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IGNMaOSuRLejLW-8IRhPzg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:30:21 INFO - Downloaded 63586817 bytes. 11:30:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IGNMaOSuRLejLW-8IRhPzg/artifacts/public/build/target.tar.bz2 11:30:21 INFO - mkdir: /builds/slave/test/properties 11:30:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:30:21 INFO - Writing to file /builds/slave/test/properties/build_url 11:30:21 INFO - Contents: 11:30:21 INFO - build_url:https://queue.taskcluster.net/v1/task/IGNMaOSuRLejLW-8IRhPzg/artifacts/public/build/target.tar.bz2 11:30:21 INFO - Running post-action listener: _resource_record_post_action 11:30:21 INFO - Running post-action listener: find_tests_for_verification 11:30:21 INFO - Running post-action listener: set_extra_try_arguments 11:30:21 INFO - [mozharness: 2017-09-07 18:30:21.047087Z] Finished download-and-extract step (success) 11:30:21 INFO - [mozharness: 2017-09-07 18:30:21.047186Z] Running populate-webroot step. 11:30:21 INFO - Running pre-action listener: _resource_record_pre_action 11:30:21 INFO - Running main action method: populate_webroot 11:30:21 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:30:21 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:30:21 INFO - 'tests': ['tresize', 11:30:21 INFO - 'tcanvasmark']}, 11:30:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:30:21 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:30:21 INFO - 'tests': ['dromaeo_css', 11:30:21 INFO - 'kraken']}, 11:30:21 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:30:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:30:21 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:30:21 INFO - 'talos_options': ['--disable-stylo'], 11:30:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:30:21 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:30:21 INFO - 'tests': ['damp', 'tps']}, 11:30:21 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:30:21 INFO - 'talos_options': ['--disable-stylo'], 11:30:21 INFO - 'tests': ['damp', 'tps']}, 11:30:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:30:21 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:30:21 INFO - 'tests': ['dromaeo_dom']}, 11:30:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:30:21 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:30:21 INFO - 'tests': ['basic_compositor_video', 11:30:21 INFO - 'glvideo']}, 11:30:21 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:30:21 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:30:21 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:30:21 INFO - 'talos_options': ['--disable-stylo'], 11:30:21 INFO - 'tests': ['ts_paint_webext', 11:30:21 INFO - 'tp5o_webext']}, 11:30:21 INFO - 'other-e10s': {'tests': ['a11yr', 11:30:21 INFO - 'ts_paint', 11:30:21 INFO - 'tpaint', 11:30:21 INFO - 'sessionrestore', 11:30:21 INFO - 'sessionrestore_many_windows', 11:30:21 INFO - 'sessionrestore_no_auto_restore', 11:30:21 INFO - 'tabpaint']}, 11:30:21 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:30:21 INFO - 'tests': ['a11yr', 11:30:21 INFO - 'ts_paint', 11:30:21 INFO - 'tpaint', 11:30:21 INFO - 'sessionrestore', 11:30:21 INFO - 'sessionrestore_many_windows', 11:30:21 INFO - 'sessionrestore_no_auto_restore', 11:30:21 INFO - 'tabpaint']}, 11:30:21 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 11:30:21 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 11:30:21 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:30:21 INFO - 'tests': ['bloom_basic_singleton']}, 11:30:21 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:30:21 INFO - 'tests': ['bloom_basic']}, 11:30:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:30:21 INFO - 'tsvgr_opacity', 11:30:21 INFO - 'tart', 11:30:21 INFO - 'tscrollx', 11:30:21 INFO - 'tsvg_static']}, 11:30:21 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:30:21 INFO - 'tests': ['tsvgx', 11:30:21 INFO - 'tsvgr_opacity', 11:30:21 INFO - 'tart', 11:30:21 INFO - 'tscrollx', 11:30:21 INFO - 'tsvg_static']}, 11:30:21 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:30:21 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:30:21 INFO - 'talos_options': ['--disable-stylo'], 11:30:21 INFO - 'tests': ['tp5o']}, 11:30:21 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:30:21 INFO - 'talos_options': ['--mitmproxy', 11:30:21 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:30:21 INFO - '--firstNonBlankPaint'], 11:30:21 INFO - 'tests': ['tp6_google', 11:30:21 INFO - 'tp6_youtube', 11:30:21 INFO - 'tp6_amazon', 11:30:21 INFO - 'tp6_facebook']}, 11:30:21 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:30:21 INFO - 'talos_options': ['--disable-stylo', 11:30:21 INFO - '--mitmproxy', 11:30:21 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:30:21 INFO - '--firstNonBlankPaint'], 11:30:21 INFO - 'tests': ['tp6_google', 11:30:21 INFO - 'tp6_youtube', 11:30:21 INFO - 'tp6_amazon', 11:30:21 INFO - 'tp6_facebook']}, 11:30:21 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:30:21 INFO - 'talos_options': ['--stylo-threads=1', 11:30:21 INFO - '--mitmproxy', 11:30:21 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:30:21 INFO - '--firstNonBlankPaint'], 11:30:21 INFO - 'tests': ['tp6_google', 11:30:21 INFO - 'tp6_youtube', 11:30:21 INFO - 'tp6_amazon', 11:30:21 INFO - 'tp6_facebook']}, 11:30:21 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:30:21 INFO - 'talos_options': ['--xperf_path', 11:30:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:30:21 INFO - 'tests': ['tp5n']}, 11:30:21 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:30:21 INFO - 'talos_options': ['--disable-stylo', 11:30:21 INFO - '--xperf_path', 11:30:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:30:21 INFO - 'tests': ['tp5n']}}} 11:30:21 INFO - Running post-action listener: _resource_record_post_action 11:30:21 INFO - [mozharness: 2017-09-07 18:30:21.062100Z] Finished populate-webroot step (success) 11:30:21 INFO - [mozharness: 2017-09-07 18:30:21.062189Z] Running create-virtualenv step. 11:30:21 INFO - Running pre-action listener: _resource_record_pre_action 11:30:21 INFO - Running main action method: create_virtualenv 11:30:21 INFO - Creating virtualenv /builds/slave/test/build/venv 11:30:21 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:30:21 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 11:30:21 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:30:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:30:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:30:21 INFO - Installing distribute.............................................................................................................................................................................................done. 11:30:21 INFO - Installing pip...............done. 11:30:21 INFO - Return code: 0 11:30:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:30:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:30:22 INFO - Reading from file tmpfile_stdout 11:30:22 INFO - Output received: 11:30:22 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 11:30:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:30: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')]} 11:30:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:30: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')]} 11:30:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:30:22 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 0x211a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2486a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248a090>, '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 0x248ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2484f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1504808988.182962-1302296783', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:30:22 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 11:30:22 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 11:30:22 INFO - Using env: {'DISPLAY': ':0', 11:30:22 INFO - 'HOME': '/home/cltbld', 11:30:22 INFO - 'LANG': 'en_US.UTF-8', 11:30:22 INFO - 'LANGUAGE': 'en_US:en', 11:30:22 INFO - 'LOGNAME': 'cltbld', 11:30:22 INFO - 'MAIL': '/var/mail/cltbld', 11:30:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:30:22 INFO - 'MOZ_NO_REMOTE': '1', 11:30:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:30:22 INFO - 'NO_EM_RESTART': '1', 11:30:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:30:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:30:22 INFO - 'PWD': '/builds/slave/test', 11:30:22 INFO - 'SHELL': '/bin/bash', 11:30:22 INFO - 'SHLVL': '1', 11:30:22 INFO - 'TERM': 'linux', 11:30:22 INFO - 'TMOUT': '86400', 11:30:22 INFO - 'USER': 'cltbld', 11:30:22 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1504808988.182962-1302296783', 11:30:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:30:22 INFO - '_': '/tools/buildbot/bin/python'} 11:30:23 INFO - Ignoring indexes: http://pypi.python.org/simple/ 11:30:23 INFO - Downloading/unpacking pip>=1.5 11:30:23 INFO - Running setup.py egg_info for package pip 11:30:23 INFO - warning: no files found matching 'pip/cacert.pem' 11:30:23 INFO - warning: no files found matching '*.html' under directory 'docs' 11:30:23 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:30:23 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:30:23 INFO - Installing collected packages: pip 11:30:23 INFO - Found existing installation: pip 1.1 11:30:23 INFO - Uninstalling pip: 11:30:23 INFO - Successfully uninstalled pip 11:30:23 INFO - Running setup.py install for pip 11:30:23 INFO - warning: no files found matching 'pip/cacert.pem' 11:30:23 INFO - warning: no files found matching '*.html' under directory 'docs' 11:30:23 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:30:23 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:30:23 INFO - Installing pip script to /builds/slave/test/build/venv/bin 11:30:23 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 11:30:23 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 11:30:23 INFO - Successfully installed pip 11:30:23 INFO - Cleaning up... 11:30:23 INFO - Return code: 0 11:30:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:30:23 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')]} 11:30:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:30:23 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')]} 11:30:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:30:23 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 0x211a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2486a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248a090>, '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 0x248ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2484f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1504808988.182962-1302296783', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:30:23 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 11:30:23 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 11:30:23 INFO - Using env: {'DISPLAY': ':0', 11:30:23 INFO - 'HOME': '/home/cltbld', 11:30:23 INFO - 'LANG': 'en_US.UTF-8', 11:30:23 INFO - 'LANGUAGE': 'en_US:en', 11:30:23 INFO - 'LOGNAME': 'cltbld', 11:30:23 INFO - 'MAIL': '/var/mail/cltbld', 11:30:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:30:23 INFO - 'MOZ_NO_REMOTE': '1', 11:30:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:30:23 INFO - 'NO_EM_RESTART': '1', 11:30:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:30:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:30:23 INFO - 'PWD': '/builds/slave/test', 11:30:23 INFO - 'SHELL': '/bin/bash', 11:30:23 INFO - 'SHLVL': '1', 11:30:23 INFO - 'TERM': 'linux', 11:30:23 INFO - 'TMOUT': '86400', 11:30:23 INFO - 'USER': 'cltbld', 11:30:23 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1504808988.182962-1302296783', 11:30:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:30:23 INFO - '_': '/tools/buildbot/bin/python'} 11:30:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:30:23 INFO - Downloading/unpacking psutil>=3.1.1 11:30:23 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 11:30:23 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 11:30:23 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 11:30:23 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 11:30:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:30:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:30:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:30:24 INFO - Installing collected packages: psutil 11:30:24 INFO - Running setup.py install for psutil 11:30:24 INFO - building 'psutil._psutil_linux' extension 11:30:24 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:30:24 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:30:24 INFO - building 'psutil._psutil_posix' extension 11:30:24 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:30:25 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:30:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:30:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:30:25 INFO - Successfully installed psutil 11:30:25 INFO - Cleaning up... 11:30:25 INFO - Return code: 0 11:30:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:30:25 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')]} 11:30:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:30:25 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')]} 11:30:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:30:25 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 0x211a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2486a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248a090>, '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 0x248ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2484f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1504808988.182962-1302296783', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:30:25 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 11:30:25 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 11:30:25 INFO - Using env: {'DISPLAY': ':0', 11:30:25 INFO - 'HOME': '/home/cltbld', 11:30:25 INFO - 'LANG': 'en_US.UTF-8', 11:30:25 INFO - 'LANGUAGE': 'en_US:en', 11:30:25 INFO - 'LOGNAME': 'cltbld', 11:30:25 INFO - 'MAIL': '/var/mail/cltbld', 11:30:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:30:25 INFO - 'MOZ_NO_REMOTE': '1', 11:30:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:30:25 INFO - 'NO_EM_RESTART': '1', 11:30:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:30:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:30:25 INFO - 'PWD': '/builds/slave/test', 11:30:25 INFO - 'SHELL': '/bin/bash', 11:30:25 INFO - 'SHLVL': '1', 11:30:25 INFO - 'TERM': 'linux', 11:30:25 INFO - 'TMOUT': '86400', 11:30:25 INFO - 'USER': 'cltbld', 11:30:25 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1504808988.182962-1302296783', 11:30:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:30:25 INFO - '_': '/tools/buildbot/bin/python'} 11:30:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:30:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:30:25 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 11:30:25 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 11:30:25 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 11:30:25 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 11:30:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:30:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:30:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:30:26 INFO - Installing collected packages: mozsystemmonitor 11:30:26 INFO - Running setup.py install for mozsystemmonitor 11:30:26 INFO - Successfully installed mozsystemmonitor 11:30:26 INFO - Cleaning up... 11:30:26 INFO - Return code: 0 11:30:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:30: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')]} 11:30:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:30: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')]} 11:30:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:30:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x211a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2486a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248a090>, '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 0x248ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2484f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1504808988.182962-1302296783', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:30:26 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 11:30:26 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 11:30:26 INFO - Using env: {'DISPLAY': ':0', 11:30:26 INFO - 'HOME': '/home/cltbld', 11:30:26 INFO - 'LANG': 'en_US.UTF-8', 11:30:26 INFO - 'LANGUAGE': 'en_US:en', 11:30:26 INFO - 'LOGNAME': 'cltbld', 11:30:26 INFO - 'MAIL': '/var/mail/cltbld', 11:30:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:30:26 INFO - 'MOZ_NO_REMOTE': '1', 11:30:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:30:26 INFO - 'NO_EM_RESTART': '1', 11:30:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:30:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:30:26 INFO - 'PWD': '/builds/slave/test', 11:30:26 INFO - 'SHELL': '/bin/bash', 11:30:26 INFO - 'SHLVL': '1', 11:30:26 INFO - 'TERM': 'linux', 11:30:26 INFO - 'TMOUT': '86400', 11:30:26 INFO - 'USER': 'cltbld', 11:30:26 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1504808988.182962-1302296783', 11:30:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:30:26 INFO - '_': '/tools/buildbot/bin/python'} 11:30:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:30:26 INFO - Downloading/unpacking jsonschema==2.5.1 11:30: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 11:30: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 11:30: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 11:30: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 11:30:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:30:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:30:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:30:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:30:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:30:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:30:28 INFO - Downloading functools32-3.2.3-2.tar.gz 11:30:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:30:28 INFO - warning: no files found matching '*.txt' 11:30:28 INFO - no previously-included directories found matching 'build' 11:30:28 INFO - no previously-included directories found matching 'dist' 11:30:28 INFO - no previously-included directories found matching '.git*' 11:30:28 INFO - Installing collected packages: jsonschema, functools32 11:30:28 INFO - Running setup.py install for functools32 11:30:28 INFO - warning: no files found matching '*.txt' 11:30:28 INFO - no previously-included directories found matching 'build' 11:30:28 INFO - no previously-included directories found matching 'dist' 11:30:28 INFO - no previously-included directories found matching '.git*' 11:30:28 INFO - Successfully installed jsonschema functools32 11:30:28 INFO - Cleaning up... 11:30:28 INFO - Return code: 0 11:30:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:30: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')]} 11:30:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:30: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')]} 11:30:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:30: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', '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 0x211a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2486a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248a090>, '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 0x248ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2484f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1504808988.182962-1302296783', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:30: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:30: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 functools32==3.2.3-2 11:30:28 INFO - Using env: {'DISPLAY': ':0', 11:30:28 INFO - 'HOME': '/home/cltbld', 11:30:28 INFO - 'LANG': 'en_US.UTF-8', 11:30:28 INFO - 'LANGUAGE': 'en_US:en', 11:30:28 INFO - 'LOGNAME': 'cltbld', 11:30:28 INFO - 'MAIL': '/var/mail/cltbld', 11:30:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:30:28 INFO - 'MOZ_NO_REMOTE': '1', 11:30:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:30:28 INFO - 'NO_EM_RESTART': '1', 11:30:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:30:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:30:28 INFO - 'PWD': '/builds/slave/test', 11:30:28 INFO - 'SHELL': '/bin/bash', 11:30:28 INFO - 'SHLVL': '1', 11:30:28 INFO - 'TERM': 'linux', 11:30:28 INFO - 'TMOUT': '86400', 11:30:28 INFO - 'USER': 'cltbld', 11:30:28 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1504808988.182962-1302296783', 11:30:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:30:28 INFO - '_': '/tools/buildbot/bin/python'} 11:30:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:30:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:30:28 INFO - Cleaning up... 11:30:28 INFO - Return code: 0 11:30:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:30: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')]} 11:30:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:30: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')]} 11:30:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:30: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', '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 0x211a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2486a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248a090>, '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 0x248ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2484f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1504808988.182962-1302296783', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:30: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:30: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 blobuploader==1.2.4 11:30:28 INFO - Using env: {'DISPLAY': ':0', 11:30:28 INFO - 'HOME': '/home/cltbld', 11:30:28 INFO - 'LANG': 'en_US.UTF-8', 11:30:28 INFO - 'LANGUAGE': 'en_US:en', 11:30:28 INFO - 'LOGNAME': 'cltbld', 11:30:28 INFO - 'MAIL': '/var/mail/cltbld', 11:30:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:30:28 INFO - 'MOZ_NO_REMOTE': '1', 11:30:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:30:28 INFO - 'NO_EM_RESTART': '1', 11:30:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:30:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:30:28 INFO - 'PWD': '/builds/slave/test', 11:30:28 INFO - 'SHELL': '/bin/bash', 11:30:28 INFO - 'SHLVL': '1', 11:30:28 INFO - 'TERM': 'linux', 11:30:28 INFO - 'TMOUT': '86400', 11:30:28 INFO - 'USER': 'cltbld', 11:30:28 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1504808988.182962-1302296783', 11:30:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:30:28 INFO - '_': '/tools/buildbot/bin/python'} 11:30:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:30:28 INFO - Downloading/unpacking blobuploader==1.2.4 11:30:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:30:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:30:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:30:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:30:29 INFO - Downloading blobuploader-1.2.4.tar.gz 11:30:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:30:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:30:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:30:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:30:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:30:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:30:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:30:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:30:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:30:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:30:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:30:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:30:30 INFO - Downloading docopt-0.6.1.tar.gz 11:30:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:30:30 INFO - Installing collected packages: blobuploader, requests, docopt 11:30:30 INFO - Running setup.py install for blobuploader 11:30:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:30:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:30:30 INFO - Running setup.py install for requests 11:30:30 INFO - Running setup.py install for docopt 11:30:31 INFO - Successfully installed blobuploader requests docopt 11:30:31 INFO - Cleaning up... 11:30:31 INFO - Return code: 0 11:30:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:30:31 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')]} 11:30:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:30:31 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')]} 11:30:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:30:31 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 0x211a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2486a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248a090>, '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 0x248ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2484f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1504808988.182962-1302296783', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:30:31 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 11:30:31 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 11:30:31 INFO - Using env: {'DISPLAY': ':0', 11:30:31 INFO - 'HOME': '/home/cltbld', 11:30:31 INFO - 'LANG': 'en_US.UTF-8', 11:30:31 INFO - 'LANGUAGE': 'en_US:en', 11:30:31 INFO - 'LOGNAME': 'cltbld', 11:30:31 INFO - 'MAIL': '/var/mail/cltbld', 11:30:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:30:31 INFO - 'MOZ_NO_REMOTE': '1', 11:30:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:30:31 INFO - 'NO_EM_RESTART': '1', 11:30:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:30:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:30:31 INFO - 'PWD': '/builds/slave/test', 11:30:31 INFO - 'SHELL': '/bin/bash', 11:30:31 INFO - 'SHLVL': '1', 11:30:31 INFO - 'TERM': 'linux', 11:30:31 INFO - 'TMOUT': '86400', 11:30:31 INFO - 'USER': 'cltbld', 11:30:31 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1504808988.182962-1302296783', 11:30:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:30:31 INFO - '_': '/tools/buildbot/bin/python'} 11:30:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:30:31 INFO - Running setup.py (path:/tmp/pip-8FYJ9U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:30:31 INFO - Running setup.py (path:/tmp/pip-MEF4iS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:30:31 INFO - Running setup.py (path:/tmp/pip-gzuDm5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:30:31 INFO - Running setup.py (path:/tmp/pip-Qa8wXI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:30:31 INFO - Running setup.py (path:/tmp/pip-DAg8x9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:30:31 INFO - Running setup.py (path:/tmp/pip-AshDCy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:30:31 INFO - Running setup.py (path:/tmp/pip-5HTGLF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:30:31 INFO - Running setup.py (path:/tmp/pip-wNAdAH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:30:31 INFO - Running setup.py (path:/tmp/pip-tYJGuQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:30:31 INFO - Running setup.py (path:/tmp/pip-Ke_jhH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:30:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:30:32 INFO - Running setup.py (path:/tmp/pip-LQOPZs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:30:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:30:32 INFO - Running setup.py (path:/tmp/pip-F463PL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:30:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:30:32 INFO - Running setup.py (path:/tmp/pip-iOtq34-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:30:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:30:32 INFO - Running setup.py (path:/tmp/pip-uXG4He-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:30:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:30:32 INFO - Running setup.py (path:/tmp/pip-7q9Mhy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:30:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:30:32 INFO - Running setup.py (path:/tmp/pip-A6CyWw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:30:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:30:32 INFO - Running setup.py (path:/tmp/pip-qgQdyX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:30:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:30:32 INFO - Running setup.py install for manifestparser 11:30:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:30:32 INFO - Running setup.py install for mozcrash 11:30:32 INFO - Running setup.py install for mozdebug 11:30:32 INFO - Running setup.py install for mozdevice 11:30:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:30:32 INFO - Running setup.py install for mozfile 11:30:33 INFO - Running setup.py install for mozhttpd 11:30:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:30:33 INFO - Running setup.py install for mozinfo 11:30:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:30:33 INFO - Running setup.py install for mozInstall 11:30:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:30:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:30:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:30:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:30:33 INFO - Running setup.py install for mozleak 11:30:33 INFO - Running setup.py install for mozlog 11:30:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:30:33 INFO - Running setup.py install for moznetwork 11:30:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:30:33 INFO - Running setup.py install for mozprocess 11:30:33 INFO - Running setup.py install for mozprofile 11:30:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:30:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:30:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:30:33 INFO - Running setup.py install for mozrunner 11:30:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:30:33 INFO - Running setup.py install for mozscreenshot 11:30:34 INFO - Running setup.py install for moztest 11:30:34 INFO - Running setup.py install for mozversion 11:30:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:30:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:30:34 INFO - Cleaning up... 11:30:34 INFO - Return code: 0 11:30:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:30:34 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')]} 11:30:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:30:34 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')]} 11:30:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:30:34 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 0x211a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2486a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248a090>, '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 0x248ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2484f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1504808988.182962-1302296783', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:30:34 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 11:30:34 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 11:30:34 INFO - Using env: {'DISPLAY': ':0', 11:30:34 INFO - 'HOME': '/home/cltbld', 11:30:34 INFO - 'LANG': 'en_US.UTF-8', 11:30:34 INFO - 'LANGUAGE': 'en_US:en', 11:30:34 INFO - 'LOGNAME': 'cltbld', 11:30:34 INFO - 'MAIL': '/var/mail/cltbld', 11:30:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:30:34 INFO - 'MOZ_NO_REMOTE': '1', 11:30:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:30:34 INFO - 'NO_EM_RESTART': '1', 11:30:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:30:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:30:34 INFO - 'PWD': '/builds/slave/test', 11:30:34 INFO - 'SHELL': '/bin/bash', 11:30:34 INFO - 'SHLVL': '1', 11:30:34 INFO - 'TERM': 'linux', 11:30:34 INFO - 'TMOUT': '86400', 11:30:34 INFO - 'USER': 'cltbld', 11:30:34 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1504808988.182962-1302296783', 11:30:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:30:34 INFO - '_': '/tools/buildbot/bin/python'} 11:30:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:30:34 INFO - Running setup.py (path:/tmp/pip-0wL5Z3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:30:34 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)) 11:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:30:34 INFO - Running setup.py (path:/tmp/pip-qBeGjS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:30:34 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)) 11:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:30:34 INFO - Running setup.py (path:/tmp/pip-MgNfZQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:30:34 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)) 11:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:30:34 INFO - Running setup.py (path:/tmp/pip-txRG2j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:30:34 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)) 11:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:30:34 INFO - Running setup.py (path:/tmp/pip-lJRpaI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:30:34 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)) 11:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:30:34 INFO - Running setup.py (path:/tmp/pip-PjKFvV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:30:34 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)) 11:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:30:34 INFO - Running setup.py (path:/tmp/pip-4fOiyf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:30:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 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)) 11:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:30:34 INFO - Running setup.py (path:/tmp/pip-KbiLsH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:30:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 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)) 11:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:30:35 INFO - Running setup.py (path:/tmp/pip-oImQ4R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:30:35 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)) 11:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:30:35 INFO - Running setup.py (path:/tmp/pip-QKxKFa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:30:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 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)) 11:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:30:35 INFO - Running setup.py (path:/tmp/pip-TRlnyQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:30:35 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)) 11:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:30:35 INFO - Running setup.py (path:/tmp/pip-UKTzag-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:30:35 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)) 11:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:30:35 INFO - Running setup.py (path:/tmp/pip-fF2Qb3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:30:35 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)) 11:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:30:35 INFO - Running setup.py (path:/tmp/pip-8KY6jA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:30:35 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)) 11:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:30:35 INFO - Running setup.py (path:/tmp/pip-QhmDNh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:30:35 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)) 11:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:30:35 INFO - Running setup.py (path:/tmp/pip-SMAVP2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:30:35 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)) 11:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:30:35 INFO - Running setup.py (path:/tmp/pip-3VDX4y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:30:35 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)) 11:30:35 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)) 11:30:35 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)) 11:30:35 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)) 11:30:35 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)) 11:30:35 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)) 11:30:35 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:30:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:30:35 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 11:30:35 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 11:30:35 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 11:30:35 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 11:30:36 INFO - Downloading blessings-1.6.tar.gz 11:30:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:30:36 INFO - Installing collected packages: blessings 11:30:36 INFO - Running setup.py install for blessings 11:30:36 INFO - Successfully installed blessings 11:30:36 INFO - Cleaning up... 11:30:37 INFO - Return code: 0 11:30:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:30:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:30:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:30:37 INFO - Reading from file tmpfile_stdout 11:30:37 INFO - Current package versions: 11:30:37 INFO - argparse == 1.2.1 11:30:37 INFO - blessings == 1.6 11:30:37 INFO - blobuploader == 1.2.4 11:30:37 INFO - docopt == 0.6.1 11:30:37 INFO - functools32 == 3.2.3-2 11:30:37 INFO - jsonschema == 2.5.1 11:30:37 INFO - manifestparser == 1.1 11:30:37 INFO - mozInstall == 1.13 11:30:37 INFO - mozcrash == 1.0 11:30:37 INFO - mozdebug == 0.1 11:30:37 INFO - mozdevice == 0.51 11:30:37 INFO - mozfile == 1.2 11:30:37 INFO - mozhttpd == 0.7 11:30:37 INFO - mozinfo == 0.10 11:30:37 INFO - mozleak == 0.1 11:30:37 INFO - mozlog == 3.5 11:30:37 INFO - moznetwork == 0.27 11:30:37 INFO - mozprocess == 0.25 11:30:37 INFO - mozprofile == 0.28 11:30:37 INFO - mozrunner == 6.13 11:30:37 INFO - mozscreenshot == 0.1 11:30:37 INFO - mozsystemmonitor == 0.3 11:30:37 INFO - moztest == 0.8 11:30:37 INFO - mozversion == 1.4 11:30:37 INFO - psutil == 3.1.1 11:30:37 INFO - requests == 1.2.3 11:30:37 INFO - wsgiref == 0.1.2 11:30:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:30:37 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')]} 11:30:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:30:37 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')]} 11:30:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:30:37 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 0x211a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2486a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248a090>, '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 0x248ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2484f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1504808988.182962-1302296783', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:30:37 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 11:30:37 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 11:30:37 INFO - Using env: {'DISPLAY': ':0', 11:30:37 INFO - 'HOME': '/home/cltbld', 11:30:37 INFO - 'LANG': 'en_US.UTF-8', 11:30:37 INFO - 'LANGUAGE': 'en_US:en', 11:30:37 INFO - 'LOGNAME': 'cltbld', 11:30:37 INFO - 'MAIL': '/var/mail/cltbld', 11:30:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:30:37 INFO - 'MOZ_NO_REMOTE': '1', 11:30:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:30:37 INFO - 'NO_EM_RESTART': '1', 11:30:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:30:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:30:37 INFO - 'PWD': '/builds/slave/test', 11:30:37 INFO - 'SHELL': '/bin/bash', 11:30:37 INFO - 'SHLVL': '1', 11:30:37 INFO - 'TERM': 'linux', 11:30:37 INFO - 'TMOUT': '86400', 11:30:37 INFO - 'USER': 'cltbld', 11:30:37 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1504808988.182962-1302296783', 11:30:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:30:37 INFO - '_': '/tools/buildbot/bin/python'} 11:30:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:30:37 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)) 11:30:37 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)) 11:30:37 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)) 11:30:37 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)) 11:30:37 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)) 11:30:37 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)) 11:30:37 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)) 11:30:37 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)) 11:30:37 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)) 11:30:37 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:30:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:30:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:30:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:30:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:30:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:30:38 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)) 11:30:38 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)) 11:30:38 INFO - Installing collected packages: simplejson 11:30:38 INFO - Running setup.py install for simplejson 11:30:38 INFO - building 'simplejson._speedups' extension 11:30:38 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 11:30:39 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 11:30:39 INFO - Successfully installed simplejson 11:30:39 INFO - Cleaning up... 11:30:39 INFO - Return code: 0 11:30:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:30:39 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')]} 11:30:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:30:39 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')]} 11:30:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:30:39 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 0x211a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2486a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248a090>, '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 0x248ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2484f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1504808988.182962-1302296783', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:30:39 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 11:30:39 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 11:30:39 INFO - Using env: {'DISPLAY': ':0', 11:30:39 INFO - 'HOME': '/home/cltbld', 11:30:39 INFO - 'LANG': 'en_US.UTF-8', 11:30:39 INFO - 'LANGUAGE': 'en_US:en', 11:30:39 INFO - 'LOGNAME': 'cltbld', 11:30:39 INFO - 'MAIL': '/var/mail/cltbld', 11:30:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:30:39 INFO - 'MOZ_NO_REMOTE': '1', 11:30:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:30:39 INFO - 'NO_EM_RESTART': '1', 11:30:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:30:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:30:39 INFO - 'PWD': '/builds/slave/test', 11:30:39 INFO - 'SHELL': '/bin/bash', 11:30:39 INFO - 'SHLVL': '1', 11:30:39 INFO - 'TERM': 'linux', 11:30:39 INFO - 'TMOUT': '86400', 11:30:39 INFO - 'USER': 'cltbld', 11:30:39 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1504808988.182962-1302296783', 11:30:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:30:39 INFO - '_': '/tools/buildbot/bin/python'} 11:30:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:30:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:30:39 INFO - Cleaning up... 11:30:39 INFO - Return code: 0 11:30:39 INFO - Running post-action listener: _resource_record_post_action 11:30:39 INFO - Running post-action listener: _start_resource_monitoring 11:30:39 INFO - Starting resource monitoring. 11:30:39 INFO - [mozharness: 2017-09-07 18:30:39.920817Z] Finished create-virtualenv step (success) 11:30:39 INFO - [mozharness: 2017-09-07 18:30:39.921285Z] Running install step. 11:30:39 INFO - Running pre-action listener: _resource_record_pre_action 11:30:39 INFO - Running main action method: install 11:30:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:30:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:30:40 INFO - Reading from file tmpfile_stdout 11:30:40 INFO - Detecting whether we're running mozinstall >=1.0... 11:30:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:30:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:30:40 INFO - Reading from file tmpfile_stdout 11:30:40 INFO - Output received: 11:30:40 INFO - Usage: mozinstall [options] installer 11:30:40 INFO - Options: 11:30:40 INFO - -h, --help show this help message and exit 11:30:40 INFO - -d DEST, --destination=DEST 11:30:40 INFO - Directory to install application into. [default: 11:30:40 INFO - "/builds/slave/test"] 11:30:40 INFO - --app=APP Application being installed. [default: firefox] 11:30:40 INFO - mkdir: /builds/slave/test/build/application 11:30:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:30:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:30:56 INFO - Reading from file tmpfile_stdout 11:30:56 INFO - Output received: 11:30:56 INFO - /builds/slave/test/build/application/firefox/firefox 11:30:56 INFO - Running post-action listener: _resource_record_post_action 11:30:56 INFO - [mozharness: 2017-09-07 18:30:56.691696Z] Finished install step (success) 11:30:56 INFO - [mozharness: 2017-09-07 18:30:56.691946Z] Running setup-mitmproxy step. 11:30:56 INFO - Running pre-action listener: _resource_record_pre_action 11:30:56 INFO - Running main action method: setup_mitmproxy 11:30:56 INFO - Skipping: mitmproxy is not required 11:30:56 INFO - Running post-action listener: _resource_record_post_action 11:30:56 INFO - [mozharness: 2017-09-07 18:30:56.693055Z] Finished setup-mitmproxy step (success) 11:30:56 INFO - [mozharness: 2017-09-07 18:30:56.693270Z] Running run-tests step. 11:30:56 INFO - Running pre-action listener: _resource_record_pre_action 11:30:56 INFO - Running pre-action listener: _set_gcov_prefix 11:30:56 INFO - Running main action method: run_tests 11:30:56 WARNING - Try message not found. 11:30:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:30:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:30:56 INFO - Python 2.7.3 11:30:56 INFO - Return code: 0 11:30:56 INFO - grabbing minidump binary from tooltool 11:30:56 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')]} 11:30:56 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/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 0x248a090>, '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 0x248ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2484f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:30:56 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:30:56 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:30:56 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:30:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:30:56 INFO - Return code: 0 11:30:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:30:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:30:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:30:56 INFO - ENV: RUST_BACKTRACE is now full 11:30:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:30:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:30:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IGNMaOSuRLejLW-8IRhPzg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-072', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] in /builds/slave/test/build 11:30:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IGNMaOSuRLejLW-8IRhPzg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-072 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log 11:30:56 INFO - Using env: {'DISPLAY': ':0', 11:30:56 INFO - 'HOME': '/home/cltbld', 11:30:56 INFO - 'LANG': 'en_US.UTF-8', 11:30:56 INFO - 'LANGUAGE': 'en_US:en', 11:30:56 INFO - 'LOGNAME': 'cltbld', 11:30:56 INFO - 'MAIL': '/var/mail/cltbld', 11:30:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:30:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:30:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:30:56 INFO - 'MOZ_NO_REMOTE': '1', 11:30:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:30:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:30:56 INFO - 'NO_EM_RESTART': '1', 11:30:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:30:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:30:56 INFO - 'PWD': '/builds/slave/test', 11:30:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:30:56 INFO - 'RUST_BACKTRACE': 'full', 11:30:56 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:30:56 INFO - 'SHELL': '/bin/bash', 11:30:56 INFO - 'SHLVL': '1', 11:30:56 INFO - 'TERM': 'linux', 11:30:56 INFO - 'TMOUT': '86400', 11:30:56 INFO - 'USER': 'cltbld', 11:30:56 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1504808988.182962-1302296783', 11:30:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:30:56 INFO - '_': '/tools/buildbot/bin/python'} 11:30:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IGNMaOSuRLejLW-8IRhPzg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-072', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] with output_timeout 3600 11:30:57 INFO - mozversion application_buildid: 20170907171306 11:30:57 INFO - mozversion application_changeset: 3c96d611ebd67fc219d22bcb476a72412c76f6c7 11:30:57 INFO - mozversion application_display_name: Nightly 11:30:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:30:57 INFO - mozversion application_name: Firefox 11:30:57 INFO - mozversion application_remotingname: firefox 11:30:57 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:30:57 INFO - mozversion application_vendor: Mozilla 11:30:57 INFO - mozversion application_version: 57.0a1 11:30:57 INFO - mozversion platform_buildid: 20170907171306 11:30:57 INFO - mozversion platform_changeset: 3c96d611ebd67fc219d22bcb476a72412c76f6c7 11:30:57 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:30:57 INFO - mozversion platform_version: 57.0a1 11:30:57 INFO - using testdate: 1504809057 11:30:57 INFO - actual date: 1504809057 11:30:57 INFO - starting webserver on 'localhost:43543' 11:30:57 INFO - SUITE-START | Running 2 tests 11:30:57 INFO - TEST-START | dromaeo_css 11:30:57 INFO - Initialising browser for dromaeo_css test... 11:30:57 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:43543/getInfo.html -profile /tmp/tmpV4d8xD/profile 11:30:57 INFO - TEST-INFO | started process 7205 (/builds/slave/test/build/application/firefox/firefox http://localhost:43543/getInfo.html) 11:31:02 INFO - TEST-INFO | 7205: exit 0 11:31:02 INFO - Browser initialized. 11:31:02 INFO - Running cycle 1/1 for dromaeo_css test... 11:31:02 INFO - Using env: {'DISPLAY': ':0', 11:31:02 INFO - 'HOME': '/home/cltbld', 11:31:02 INFO - 'JSGC_DISABLE_POISONING': '1', 11:31:02 INFO - 'LANG': 'en_US.UTF-8', 11:31:02 INFO - 'LANGUAGE': 'en_US:en', 11:31:02 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:31:02 INFO - 'LOGNAME': 'cltbld', 11:31:02 INFO - 'MAIL': '/var/mail/cltbld', 11:31:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:31:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:31:02 INFO - 'MOZ_CRASHREPORTER': '1', 11:31:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:02 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:31:02 INFO - 'MOZ_NO_REMOTE': '1', 11:31:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:31:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:31:02 INFO - 'NO_EM_RESTART': '1', 11:31:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:31:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:02 INFO - 'PWD': '/builds/slave/test', 11:31:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:31:02 INFO - 'RUST_BACKTRACE': 'full', 11:31:02 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:31:02 INFO - 'SHELL': '/bin/bash', 11:31:02 INFO - 'SHLVL': '1', 11:31:02 INFO - 'STYLO_FORCE_DISABLED': '1', 11:31:02 INFO - 'TERM': 'linux', 11:31:02 INFO - 'TMOUT': '86400', 11:31:02 INFO - 'USER': 'cltbld', 11:31:02 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1504808988.182962-1302296783', 11:31:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:02 INFO - '_': '/tools/buildbot/bin/python'} 11:31:02 INFO - TEST-INFO | started process 7399 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpV4d8xD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:31:03 INFO - PID 7399 | 11:31:03 INFO - PID 7399 | (/builds/slave/test/build/application/firefox/firefox:7450): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:31:03 INFO - PID 7399 | 11:31:14 INFO - PID 7399 | RSS: Main: 162918400 11:31:14 INFO - PID 7399 | 11:34:11 INFO - PID 7399 | Cycle 1(1): loaded http://localhost:43543/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43543/tests/dromaeo/cssquery-ext.html) 11:34:12 INFO - PID 7399 | RSS: Main: 165396480 11:34:12 INFO - PID 7399 | 11:37:14 INFO - PID 7399 | Cycle 1(1): loaded http://localhost:43543/tests/dromaeo/cssquery-ext.html (next: http://localhost:43543/tests/dromaeo/cssquery-jquery.html) 11:37:14 INFO - PID 7399 | RSS: Main: 162029568 11:37:14 INFO - PID 7399 | 11:40:16 INFO - PID 7399 | Cycle 1(1): loaded http://localhost:43543/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43543/tests/dromaeo/cssquery-mootools.html) 11:40:16 INFO - PID 7399 | RSS: Main: 164536320 11:40:16 INFO - PID 7399 | 11:43:18 INFO - PID 7399 | Cycle 1(1): loaded http://localhost:43543/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43543/tests/dromaeo/cssquery-prototype.html) 11:43:19 INFO - PID 7399 | RSS: Main: 162664448 11:43:19 INFO - PID 7399 | 11:46:22 INFO - PID 7399 | Cycle 1(1): loaded http://localhost:43543/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43543/tests/dromaeo/cssquery-yui.html) 11:46:22 INFO - PID 7399 | RSS: Main: 164081664 11:46:22 INFO - PID 7399 | 11:49:24 INFO - PID 7399 | Cycle 1(1): loaded http://localhost:43543/tests/dromaeo/cssquery-yui.html (next: http://localhost:43543/tests/dromaeo/cssquery-dojo.html) 11:49:24 INFO - PID 7399 | RSS: Main: 166526976 11:49:24 INFO - PID 7399 | 11:49:24 INFO - PID 7399 | __start_tp_report 11:49:24 INFO - PID 7399 | _x_x_mozilla_page_load 11:49:24 INFO - PID 7399 | _x_x_mozilla_page_load_details 11:49:24 INFO - PID 7399 | |i|pagename|runs| 11:49:24 INFO - PID 7399 | |0;dojo.html;3865.7873816940073;3873.6513713765758;3885.630865067819;3891.922161556771;3901.51231096113;6174.475169610577;6265.718042688079;6266.279377871546;6323.936760632392;6347.555671103013;6308.873822523547;6351.90472142917;6364;6448.258450278219;6461.386168314014;797.29804551243;5473.452654734515;5665.093585026397;5725.7995970141055;5759.7696092156475;5567.8886422271535;5598.524125449342;5625.915611265814;5647.745851436695;5667.886642267152;5665.8583535411535;5701.315842098933;5745.569082318842;5757.539396848263;5759.68321742304;5631.099024156116;5648.15277708347;5716.228309178249;5718.628289161191;5727.2268243786975;5583.218349431083;5611.438856114397;5650.378458369576;5687.232223649837;5699.487046165865;6330.936690633081;6353.205849268841;6354.9364506354805;6375.617462952191;6380;6825.863482730318;6830.453563714891;6834.1457317835275;6906.343897329796;6921;6868.278830722802;6884.070650462174;6953.165620125617;6964.721411143548;6966.9303306966785;6331.461825744817;6344.397282258178;6382.106505089291;6443.097966284724;6463.127477790438;7064.576125432491;7078.858422831515;7131.857362852714;7141.000259963609;7169;6779.694913728894;6814.046033555306;6870.381665650116;6876.484263680144;6904.13698287714;6870.828229294208;6885.586864788129;6941.826454338581;6942.062821519131;6962.1645402551;6755.4257888080065;6842.452603791685;6893.965530172317;6899.241083480813;6906.792796216121;6812.114425124702;6826.419754320938;6833.829154271183;6924.861502770017;6927.272636373209;4934.407871055496;4945.332380128637;5001.074801161797;5029.647924645313;5037.093323201859;4503.392042074343;4536.841210557614;4561.977190114028;4581.518940511265;4585.541445855454;6199.969000155061;6224.439800417894;6228.501719862491;6308.621482711052;6310.211223597051;6711.899321510181;6768.187817461936;6781.491388145909;6793.762218322434;6796.728130874809;6193.876122477525;6233.906491402633;6247.781327653601;6263.060540918898;6285.937140628626;5484.725763711798;5553.0559804832465;5555.972220138954;5562.888742225133;5576.219329293902;7043.2604576518725;7059.364657180879;7090.964545177241;7127.251638577978;7135.250798666066;6657.968014957786;6750.3924646782025;6791.966040169767;6914.757983470555;6920.792376228721;7094.822629434306;7115.395191408788;7168.820779480346;7172.533785303938;7185.964070179615;6746.898796517958;6754.3921047106;6836.042953986346;6856.177258728785;6856.965715171392;6843.657817109224;6859.142607174103;6883.931160688329;6930.896036559557;6957.095577574883;6670.166229221348;6690;6698.9665051676375;6711.9328806713265;6716.3955244028275;6536.444402225674;6710.228323742832;6711.295313992156;6711.832204194739;6717.496187786033;6618.305077966744;6623.569467984566;6651.534392592472;6723.092382528296;6723.663816809042;6609.966950165219;6651.16860392451;6709.530332876652;6784.7964561063245;6790.966045169743;6457.3865482779065;6479.611223326616;6489.967550162408;6527.02094685801;6576.145101136822 11:49:24 INFO - PID 7399 | |1;ext.html;945.6264775413707;956.0917128727708;981.4552923127663;1011.7976404719058;1015.3400289811622;44394;45673.77163114184;45783.54216457834;45806.08387832245;45947;41682.37476437856;41722.37416438756;41918.79040604793;42075;42194;7348.5958272295;7449.1061072671355;7484.401247900155;7497.512661677001;7534.397248220157;7360.889586656204;7412.814679632998;7427.554346739213;7433.553986760785;7442.925570744304;7970.402219833507;8424.368172387065;8424.368172387065;8424.53665048422;8451.57742112895;7850.842983140363;8301.128381519944;8353.122922093153;8377.706780262692;8381.371397145209;8114.63484143215;8219.931408916862;8228.753137405887;8235.13531079234;8235.876461853017;40766.184676306606;41210.587894120974;41258;41260;41351.793241033905;3691.335559599271;3733.663970242691;3736.9439458408146;3745.7190710696805;3750.1937083527173;33954.151146221295;34038;34088.48867266968;34187.145321366916;34241.82879085613;5185.55922746567;5196.68819870809;5211.218317252443;5218.582513398919;5219.530242278175;231501;236110;236852.99999999828;237194;237390;54147;55262.72368638131;56434.717826410604;56462.15306770402;56884;56879;57385.71307143437;57388.713056435285;57437;57511.42488575145;15196.468123615621;15408.460703875535;15459.690806183813;15587;15589;12179.269243845398;12261.203021803733;12271.079669024859;12273.631791046282;12284.570040048735;14936.551903442914;15073.321700523284;15114;15156.393744250106;15285.082895026335;5853;5937.554683398763;5958.404159584094;5980.790672326448;6021.729022194012;1077.8550684138665;1088.3361149698678;1094.1465656787718;1114.8216285394299;1115.4590023838432;25893.223203303933;26030.34924126912;26109.347266318113;26127.477450450886;26200.60699089515;1182.8580570331615;1206.4631239098517;1207.0946789907568;1212.4240985531978;1214.8056310990198;13739.24434156111;13749.243791591558;13871;13950;14241.578931581656;282670;283901;284856;286259;286894;59557;59827;64211.35788642054;64212;64562;1484.354305876947;1516.105497756329;1516.5071351810705;1517.1428143099113;1530.3343045775123;30885.417968261903;30898.845505772326;31172.68827311698;31369.372612547166;31544.211394715316;39820.2035959285;39969.2006159881;40119.39820902747;40159.59840401675;40209;241536;242497;242706;243095;243487;37822;37960.62039379682;38021;39435.40846887356;40309;49798.25302620536;49829.25256121089;49917;50202.246966294806;50517.74741126271;36557.817210913774;36742.63257367392;36835.447468287464;37023.814880926504;37164.25671486609;36885;36959.44560831536;37036.81481592575;37127;37295.44056839095;42764.14471710611;43143.78428107839;43329;43483;43679.34480982724;36251;36498.817505913365;36982.44526332054;37489.250214995;37625.4356184652;27171.456570868868;27580.034698785446;27728.168154955383;27819.44361112726;27890.30274243079 11:49:24 INFO - PID 7399 | |2;jquery.html;598.7011566269852;606.8391876152818;616.1220261127892;617.7837756785126;639.1946147853704;23115.884420577895;24001.79363260423;24023.159189428374;24145.63781543276;24187.153449629266;23908.760912390913;24959.87520062397;25671.48657026863;25688.486230275383;25708.74291257087;6774.458043356544;6836.6923488443135;6851.725930962755;6873.5875847449315;6874.10636617239;6570.770023049195;6882.9311706883045;6885.724571017154;6901.516893817435;6907.205671347784;6814.795556133299;6826.761063362784;6831.180258369002;6836;6836.5556238844565;6813.931860681429;6822.931770682304;6824.419924306415;6825.965870170667;6827.419669328113;6357.17356743625;6361.872762544724;6366.554341196118;6377.553571250014;6381.872362552723;28336.149915502567;29065.854670726512;30120.24699382511;30252.336121513308;30270.24324391886;2249.4376405898524;2289.473421113153;2293.7706229377095;2294.2314324701247;2298.1267118495034;20132.295369662137;20719.8964005179;20766.48083797902;20779.272725454535;20783.27258545959;2510.2092840755104;2602.778763805079;2642.9867850660817;2664.467106578692;2670.0654770830247;131881.34059329738;138266;152589;160069.19965400215;160807.1959640206;15151.924240378949;15806.36774529029;16073.598160045858;16155.919220403823;16467.5883102921;25201;25340.74659253384;25458;25555.233342999738;25575.360615984377;9888.110070093726;10028.69913902584;10130.645427410005;10225;10289.3311934724;9046.592903319366;9128.634854605874;9174.67888623895;9216.170544651013;9239;9615.471149086867;9787;9816.987517558884;9983.800323993479;10098.14165795901;2792.3298408381843;2829.8302101873956;2832.405194909051;2965.6589492208673;2996.865141068657;1052.3633201912885;1052.9631462898915;1053.578568572577;1058.9364638121738;1063.2450959818616;20748.58502829935;20838.37484875456;21291.68062479064;21397.25109621187;21598.568028639653;1102.7904698107334;1105.6019832860163;1106.6569363497342;1115.9107271418268;1116.542217690743;11690.064794816395;11790;11809.704757380963;11827.231229970024;11851.170418070824;557329;568137;581422;585312;596481;131320;131899;132077;132289.33855330662;134549.3272533631;1212.9090318226167;1261.9116661833766;1300.90243231758;1325.6884632111446;1329.8404191496888;22849;22975.54048918979;23083.192088276828;23136.305910822703;23153.76846231516;61231.693841530505;63697.363026369145;65681.34318656943;65853.67073164604;66703;79501;79635.20364796279;79925;80183.59908200422;81261;15438.22808859575;15720.056796592242;15741.212939352758;15766.132862692662;15778.526644200692;23335.41661458477;23479.295621131394;23745.52508949846;23865.64201537013;23995.64006539938;19202.8079719201;19276.710849337553;19406.8059319405;19553.60892782108;19784.703229451858;16164.595885102966;17163.570910727332;17175.227114779616;17445.214965326846;17491.33832285931;17663;19860.304889328803;20197.293094741613;20484.283050093174;20674.793252067288;15287.082775033534;15287.541373758804;15389.692206156038;15427.922860385626;15461.994970326892;19379.612407752047;19642.705359419906;19850.90074549618;19965.20139194416;19969.001549922155 11:49:24 INFO - PID 7399 | |3;mootools.html;1381.9101758385705;1493.977590336145;1497.3561368611493;1500.1824005916774;1504.653929596193;17341.7398739019;17863.28546858124;17863.821361786377;17881.7317740234;17886.373976910796;17235.482935511922;17373.7393939091;17468.563285917826;17483.475495735118;17485.56286092845;2759.296379423244;2827.9434411311763;2834.370237113668;2862.084133077416;2863.6563612366544;2770.8476033818133;2790.037437084203;2796.105246321178;2805.1584524642626;2807.3964097718986;2680.9463810723773;2796.846173460459;2898.666653334862;2899.072296865004;2900.898468553601;2890.9132726018042;2892.2624730693747;2916.6791652918164;2939.7501212396865;2939.7795165362577;2575.085844525185;2791.260316016257;2793.1480898326004;2794.5109605818902;2796.3568379272883;16896.746548801777;17020.82979170205;17034.914825425793;17047.48857534276;17072.48782536526;8240.793980150484;8561.529115898624;8561.785955351104;8563.058063612998;8567.82864342716;5242.0826355388035;5377.220303056074;5475.123980163155;5494.835154945358;5518.061929471999;1959.4611481842464;1966.8426525877896;1968.3170888889936;1997.8301844343248;2033.3899830051073;30193.396132077454;30445;30446.54330185049;30461.543076853864;30526.84736576325;7030.156381234285;7121.89317160243;7136.607486588184;7234.131904171533;7242;19020.144093515824;19030.33393831209;19053.904730476257;19057.80942190588;19108.617827643648;8044.637991290406;8171.937648105708;8247.917520824714;8254.380921430917;8265.8346833063;7514.211007844097;7545.886811697829;7556.58438785872;7701.807454813675;7731.226877312224;5375.650582712189;5567.582431317667;5600.747966341524;5636.802711905064;5874.206982057453;1613.5482065021579;1617.4824056302107;1620.6375104460924;1636.746304322832;1646.4978181654471;940.8917974432891;969.5830792759182;974.02110878568;985.1232403161192;1003.6035765872585;9227.677031304007;9368.156865882103;9507.619695212252;9539.713808585753;9601.135897769234;1032.9741756456149;1052.7894421115807;1056.3397876327294;1060.3266925502362;1065.1851333729703;6361.4592759615025;6452.387023232879;6701.798946031627;6781.525293229525;6823.931760682429;25393.61909571358;25614.487710245692;25619.487610248063;25656;25913.481730365664;24289.149879754124;25564.74435255661;25610.743892561208;25732;25791;11461.942690286494;11616.477258523386;11940.88059119415;11996.280223186637;12006.399680015964;9728.513574321398;10201.846972295272;10210.489475526045;10293.691189264335;10377.688669339932;20432.489187770425;21060.04384804012;21381.144754209658;21469.141234350453;22131.77868221297;21700.240491582717;22207.666884996415;22303.888480557493;22662.773372266725;22667.206647767907;13213.141145825875;13704;13762.311884405939;13776.793348099987;13780.310984450536;14747.778783318045;15072.095674259579;15170.469033583771;15199.392024318904;15206.08763474195;12574.182678125893;12633.557825476431;12645;12741.299228542148;12767.553135640208;12122.333271670142;12298.692532686755;12313.569025084438;12561.371931403575;12750.48998040068;10688.786224275316;11076.612318568812;11086.889131108908;11169.497372618414;11173.664790056311;7880.448368614142;8037.919620803951;8038.276555110068;8124.959375203086;8206.384521160817;7986.8801967971685;8012.118666946748;8147.470414423044;8164.387670924586;8189.50862948225 11:49:24 INFO - PID 7399 | |4;prototype.html;543.2910052381643;554.5618961020792;568.9402612725664;571.7798647520704;578.6383510306059;6065.696715164247;6169.1363209150695;6181.721822517986;6228.813135605939;6271.247450305964;6018.608790428619;6093.634381937087;6110.572259941806;6116.694165291739;6141.477974372184;4838.395200599925;4851.22380419133;4922.93236840527;4929.3591833061655;4936.901261974758;4802.35168252285;4853.538913803183;4856.854294371157;4883.267509873512;4926.408830940292;4774.331593576902;4811.78346974387;4860.586850117745;4868.269759536062;4878.658493905428;4815.590674792612;4822.614190864722;4867.342908707315;4882.316475693406;4903.975480122613;4387.561243875619;4408.779561021968;4420.359047938063;4443.755593442359;4448.687637147017;6059.606125601822;6099.48154406876;6102.26772787264;6142.293636231846;6176.536759743038;5686.857828554278;5716.57125715573;5725.110713464588;5794.391588883191;5796.797112101056;6414.198225221848;6477.935220647781;6501.317361677003;6506.446952009038;6587.80236592903;4934.136526107916;4937.629677774145;4961.8511444656715;4966.106100901836;4999.975000124976;6467.870642587169;6578.80263592093;6672.899906501407;6689.521448846621;6733.124693789776;5046.21783623539;5052.9747351263;5059.595232381401;5081.796728130834;5110.105731496973;5121.2574176744165;5139;5147.794088236504;5182.585393168538;5185.714785686823;5760.798372057042;5774.595778295479;5783.710814459344;5807.216025836458;5814.534837213013;6469.900116980125;6521.424037505159;6539.869202616016;6550.737970481223;6571.507136964747;1757.6641752268367;1771.6722406354866;1784.9107544622716;1787.883787553805;1797.0834874213983;1226.4547061293308;1241.9130660853652;1262.4003598290738;1278.8721127887136;1285.3765923527083;5935.465808077293;5974.551908606872;6040.154378387029;6083.756649733961;6094.878102437927;6511.837204069841;6585.6707164641575;6599.901001484982;6602.2737498875085;6629.204495460575;6041.879162416727;6057.878842423215;6122.622409957724;6130.754769809247;6221.96889015552;3475.965240347615;3510.14001569612;3514.753967222321;3543.4153364695053;3555.982220088883;7030.3321184487395;7052.435805135577;7091.219965803757;7095.964520177469;7127.5010749248095;6825.726970921207;6917.51577389588;6917.619530925847;6923.9653801730665;6936.4797640177185;6881.483888708367;6931.2375638679705;7005.894911576331;7033.659011969376;7052.224255332012;6660.134182556237;6722.999815110002;6734.107655801174;6782.1861376635115;6798.314665707117;6636.668166591555;6650.700718467584;6696.59820410777;6704.229013663491;6719.664016799043;6929.861402772017;7042.6759169472925;7058.082449281561;7060.188078371053;7064.788056358318;5024.171011783015;5061.6962982221185;5067.847964561069;5083.262926875656;5120.667156634807;6452.806415807533;6637.738829622356;6648.301928297459;6653.334666533308;6681.966590167018;6159.6612186330185;6421.422072013541;6429.678516074271;6442.194725659293;6497.610143391412;6329.936700632935;6356.618602883842;6409.4937689641965;6479.023897711243;6498.707558159799;6318.873622527615;6371;6372.362763723776;6464.896849512166;6479.902801457888;6460.804751121058;6462.644554549545;6478.708458119301;6540.411362977355;6590.637514936724;6306.4639505642535;6327.3356297589935;6381.149466654804;6418.4865210783955;6465.935340646722 11:49:24 INFO - PID 7399 | |5;yui.html;947.83412902742;987.9604815807368;990.2424645146461;991.6281394477066;1037.3879411147425;20031.499212519677;20506.897465512688;20520.897395513002;20521;20535.28126515572;15275;15297.311620977054;15489.84510154898;18502;18601.441956741284;988.5650313861913;1018.4805749067973;1022.2435397805607;1024.2522958240488;1024.5645600619744;1034.9793004139913;1053.8313869780836;1105.6738262212666;1107.1530279336314;1108.8004159251332;1111.1721767283386;1113.8162203236457;1116.3971455414066;1116.447358557511;1117.123058399157;1110.4114819145825;1115.5872327238892;1119.1270808769173;1149.1438878035917;1179.9351035693032;807.6083099696642;816.6651672814177;822.5722624235424;823.0987069159261;825.0099880143791;20678.793212067838;20764.68852967207;20804.47988800277;20876.791232087635;20890.686639700416;22274.888625556767;23175.76824231753;23420.88289558541;23452.530949380918;23465.41336466585;15871.52385428439;16767.91616041924;16808.32766689331;16823.663526729397;16840.663186736318;3977.164795392971;4007.3788562772816;4009.3585026395926;4016.4176194451643;4017.055991841915;154733;156921;158649;158797;162669;16984.235709393106;17235.74146387805;17531.29874805019;17546.736798948026;17905.37331193428;31915.138130380765;33001.17497062593;33377.66622333794;33554.99335019953;35270.64729352674;9013.819723605491;9098.727038188865;9165;9165.358424910326;9182.540872956326;4383.715058521186;4517.887052823706;4520.412346394947;4527.864164075083;4533.274676051816;5772.884542309131;6057.757689692363;6096.451319381277;6105.26736791579;6157.753689852445;1077.5905156040653;1092.3118435385657;1105.038616403718;1108.7616162525096;1108.9445527723742;757.5909009135005;765.223298352173;778.622368151446;781.675604624086;783.7217787685404;12026.759464810655;12174.269543827399;12414.875851241553;13064.150830196197;13428.724271194222;715.9856802863914;719.3489891648067;726.4116065986568;736.2821249281907;737.5685224143829;5788.739506722208;5876.559258055578;5930.169776231331;5959.791407300723;6045.637261764308;147521;148783;149935.2503237477;149978;153669.23165384325;121646;122025.38987305007;124880.37559812143;125536;128934;106065.46967265115;107757;107924.46037769761;109177.90822091837;110191;13501.932490337878;13879.444822207402;13968.441262349392;14354.641133971734;14589.270536473347;50018.499815001385;50707.49292507028;51181.7440912793;52952.20571691351;54419.18371224514;82074.58962705387;88164;88657.55671221603;90480.54759726423;91364;19516.21935122579;20366;20402.28591999273;20486.18055277772;20666.793332066485;19144.138513766637;19375.709364359263;19802.60394792125;19884.304049358205;21541.138354465646;17984.550386239924;18189.545261368043;18704.53238669044;19383.4184974451;19615.60768784645;17222.569435764206;17538.649227015132;17576.56058598545;17691.823081769016;17709.114544272994;19636.90181549083;20302.665193502937;20431;20460.38618841437;20982.055807489003;12681.429335679732;12701;12761.298128603015;12809.23144611289;13889;15405.845941540889;15415.460458883885;15740.527784166494;15756.369745210523;16429.342826286815 11:49:24 INFO - PID 7399 | __end_tp_report 11:49:24 INFO - PID 7399 | __start_cc_report 11:49:24 INFO - PID 7399 | _x_x_mozilla_cycle_collect,362 11:49:24 INFO - PID 7399 | __end_cc_report 11:49:24 INFO - PID 7399 | __startTimestamp1504810164387__endTimestamp 11:49:24 INFO - PID 7399 | 11:49:24 INFO - PID 7399 | ------- Summary: start ------- 11:49:24 INFO - PID 7399 | Number of tests: 6 11:49:24 INFO - PID 7399 | 11:49:24 INFO - PID 7399 | [#0] dojo.html Cycles:165 Average:6285.92 Median:6623.57 stddev:873.56 (13.2%) stddev-sans-first:855.36 11:49:24 INFO - PID 7399 | Values: 3865.8 3873.7 3885.6 3891.9 3901.5 6174.5 6265.7 6266.3 6323.9 6347.6 6308.9 6351.9 6364.0 6448.3 6461.4 797.3 5473.5 5665.1 5725.8 5759.8 5567.9 5598.5 5625.9 5647.7 5667.9 5665.9 5701.3 5745.6 5757.5 5759.7 5631.1 5648.2 5716.2 5718.6 5727.2 5583.2 5611.4 5650.4 5687.2 5699.5 6330.9 6353.2 6354.9 6375.6 6380.0 6825.9 6830.5 6834.1 6906.3 6921.0 6868.3 6884.1 6953.2 6964.7 6966.9 6331.5 6344.4 6382.1 6443.1 6463.1 7064.6 7078.9 7131.9 7141.0 7169.0 6779.7 6814.0 6870.4 6876.5 6904.1 6870.8 6885.6 6941.8 6942.1 6962.2 6755.4 6842.5 6894.0 6899.2 6906.8 6812.1 6826.4 6833.8 6924.9 6927.3 4934.4 4945.3 5001.1 5029.6 5037.1 4503.4 4536.8 4562.0 4581.5 4585.5 6200.0 6224.4 6228.5 6308.6 6310.2 6711.9 6768.2 6781.5 6793.8 6796.7 6193.9 6233.9 6247.8 6263.1 6285.9 5484.7 5553.1 5556.0 5562.9 5576.2 7043.3 7059.4 7091.0 7127.3 7135.3 6658.0 6750.4 6792.0 6914.8 6920.8 7094.8 7115.4 7168.8 7172.5 7186.0 6746.9 6754.4 6836.0 6856.2 6857.0 6843.7 6859.1 6883.9 6930.9 6957.1 6670.2 6690.0 6699.0 6711.9 6716.4 6536.4 6710.2 6711.3 6711.8 6717.5 6618.3 6623.6 6651.5 6723.1 6723.7 6610.0 6651.2 6709.5 6784.8 6791.0 6457.4 6479.6 6490.0 6527.0 6576.1 11:49:24 INFO - PID 7399 | 11:49:24 INFO - PID 7399 | [#1] ext.html Cycles:180 Average:44047.17 Median:20687.81 stddev:66441.51 (321.2%) stddev-sans-first:66549.08 11:49:24 INFO - PID 7399 | Values: 945.6 956.1 981.5 1011.8 1015.3 44394.0 45673.8 45783.5 45806.1 45947.0 41682.4 41722.4 41918.8 42075.0 42194.0 7348.6 7449.1 7484.4 7497.5 7534.4 7360.9 7412.8 7427.6 7433.6 7442.9 7970.4 8424.4 8424.4 8424.5 8451.6 7850.8 8301.1 8353.1 8377.7 8381.4 8114.6 8219.9 8228.8 8235.1 8235.9 40766.2 41210.6 41258.0 41260.0 41351.8 3691.3 3733.7 3736.9 3745.7 3750.2 33954.2 34038.0 34088.5 34187.1 34241.8 5185.6 5196.7 5211.2 5218.6 5219.5 231501.0 236110.0 236853.0 237194.0 237390.0 54147.0 55262.7 56434.7 56462.2 56884.0 56879.0 57385.7 57388.7 57437.0 57511.4 15196.5 15408.5 15459.7 15587.0 15589.0 12179.3 12261.2 12271.1 12273.6 12284.6 14936.6 15073.3 15114.0 15156.4 15285.1 5853.0 5937.6 5958.4 5980.8 6021.7 1077.9 1088.3 1094.1 1114.8 1115.5 25893.2 26030.3 26109.3 26127.5 26200.6 1182.9 1206.5 1207.1 1212.4 1214.8 13739.2 13749.2 13871.0 13950.0 14241.6 282670.0 283901.0 284856.0 286259.0 286894.0 59557.0 59827.0 64211.4 64212.0 64562.0 1484.4 1516.1 1516.5 1517.1 1530.3 30885.4 30898.8 31172.7 31369.4 31544.2 39820.2 39969.2 40119.4 40159.6 40209.0 241536.0 242497.0 242706.0 243095.0 243487.0 37822.0 37960.6 38021.0 39435.4 40309.0 49798.3 49829.3 49917.0 50202.2 50517.7 36557.8 36742.6 36835.4 37023.8 37164.3 36885.0 36959.4 37036.8 37127.0 37295.4 42764.1 43143.8 43329.0 43483.0 43679.3 36251.0 36498.8 36982.4 37489.3 37625.4 27171.5 27580.0 27728.2 27819.4 27890.3 11:49:24 INFO - PID 7399 | 11:49:24 INFO - PID 7399 | [#2] jquery.html Cycles:180 Average:39050.22 Median:23244.59 stddev:97025.52 (417.4%) stddev-sans-first:97254.75 11:49:24 INFO - PID 7399 | Values: 598.7 606.8 616.1 617.8 639.2 23115.9 24001.8 24023.2 24145.6 24187.2 23908.8 24959.9 25671.5 25688.5 25708.7 6774.5 6836.7 6851.7 6873.6 6874.1 6570.8 6882.9 6885.7 6901.5 6907.2 6814.8 6826.8 6831.2 6836.0 6836.6 6813.9 6822.9 6824.4 6826.0 6827.4 6357.2 6361.9 6366.6 6377.6 6381.9 28336.1 29065.9 30120.2 30252.3 30270.2 2249.4 2289.5 2293.8 2294.2 2298.1 20132.3 20719.9 20766.5 20779.3 20783.3 2510.2 2602.8 2643.0 2664.5 2670.1 131881.3 138266.0 152589.0 160069.2 160807.2 15151.9 15806.4 16073.6 16155.9 16467.6 25201.0 25340.7 25458.0 25555.2 25575.4 9888.1 10028.7 10130.6 10225.0 10289.3 9046.6 9128.6 9174.7 9216.2 9239.0 9615.5 9787.0 9817.0 9983.8 10098.1 2792.3 2829.8 2832.4 2965.7 2996.9 1052.4 1053.0 1053.6 1058.9 1063.2 20748.6 20838.4 21291.7 21397.3 21598.6 1102.8 1105.6 1106.7 1115.9 1116.5 11690.1 11790.0 11809.7 11827.2 11851.2 557329.0 568137.0 581422.0 585312.0 596481.0 131320.0 131899.0 132077.0 132289.3 134549.3 1212.9 1261.9 1300.9 1325.7 1329.8 22849.0 22975.5 23083.2 23136.3 23153.8 61231.7 63697.4 65681.3 65853.7 66703.0 79501.0 79635.2 79925.0 80183.6 81261.0 15438.2 15720.1 15741.2 15766.1 15778.5 23335.4 23479.3 23745.5 23865.6 23995.6 19202.8 19276.7 19406.8 19553.6 19784.7 16164.6 17163.6 17175.2 17445.2 17491.3 17663.0 19860.3 20197.3 20484.3 20674.8 15287.1 15287.5 15389.7 15427.9 15462.0 19379.6 19642.7 19850.9 19965.2 19969.0 11:49:24 INFO - PID 7399 | 11:49:24 INFO - PID 7399 | [#3] mootools.html Cycles:180 Average:10529.91 Median:25637.74 stddev:7796.39 (30.4%) stddev-sans-first:7787.96 11:49:24 INFO - PID 7399 | Values: 1381.9 1494.0 1497.4 1500.2 1504.7 17341.7 17863.3 17863.8 17881.7 17886.4 17235.5 17373.7 17468.6 17483.5 17485.6 2759.3 2827.9 2834.4 2862.1 2863.7 2770.8 2790.0 2796.1 2805.2 2807.4 2680.9 2796.8 2898.7 2899.1 2900.9 2890.9 2892.3 2916.7 2939.8 2939.8 2575.1 2791.3 2793.1 2794.5 2796.4 16896.7 17020.8 17034.9 17047.5 17072.5 8240.8 8561.5 8561.8 8563.1 8567.8 5242.1 5377.2 5475.1 5494.8 5518.1 1959.5 1966.8 1968.3 1997.8 2033.4 30193.4 30445.0 30446.5 30461.5 30526.8 7030.2 7121.9 7136.6 7234.1 7242.0 19020.1 19030.3 19053.9 19057.8 19108.6 8044.6 8171.9 8247.9 8254.4 8265.8 7514.2 7545.9 7556.6 7701.8 7731.2 5375.7 5567.6 5600.7 5636.8 5874.2 1613.5 1617.5 1620.6 1636.7 1646.5 940.9 969.6 974.0 985.1 1003.6 9227.7 9368.2 9507.6 9539.7 9601.1 1033.0 1052.8 1056.3 1060.3 1065.2 6361.5 6452.4 6701.8 6781.5 6823.9 25393.6 25614.5 25619.5 25656.0 25913.5 24289.1 25564.7 25610.7 25732.0 25791.0 11461.9 11616.5 11940.9 11996.3 12006.4 9728.5 10201.8 10210.5 10293.7 10377.7 20432.5 21060.0 21381.1 21469.1 22131.8 21700.2 22207.7 22303.9 22662.8 22667.2 13213.1 13704.0 13762.3 13776.8 13780.3 14747.8 15072.1 15170.5 15199.4 15206.1 12574.2 12633.6 12645.0 12741.3 12767.6 12122.3 12298.7 12313.6 12561.4 12750.5 10688.8 11076.6 11086.9 11169.5 11173.7 7880.4 8037.9 8038.3 8125.0 8206.4 7986.9 8012.1 8147.5 8164.4 8189.5 11:49:24 INFO - PID 7399 | 11:49:24 INFO - PID 7399 | [#4] prototype.html Cycles:180 Average:5547.05 Median:6126.69 stddev:1564.31 (25.5%) stddev-sans-first:1522.94 11:49:24 INFO - PID 7399 | Values: 543.3 554.6 568.9 571.8 578.6 6065.7 6169.1 6181.7 6228.8 6271.2 6018.6 6093.6 6110.6 6116.7 6141.5 4838.4 4851.2 4922.9 4929.4 4936.9 4802.4 4853.5 4856.9 4883.3 4926.4 4774.3 4811.8 4860.6 4868.3 4878.7 4815.6 4822.6 4867.3 4882.3 4904.0 4387.6 4408.8 4420.4 4443.8 4448.7 6059.6 6099.5 6102.3 6142.3 6176.5 5686.9 5716.6 5725.1 5794.4 5796.8 6414.2 6477.9 6501.3 6506.4 6587.8 4934.1 4937.6 4961.9 4966.1 5000.0 6467.9 6578.8 6672.9 6689.5 6733.1 5046.2 5053.0 5059.6 5081.8 5110.1 5121.3 5139.0 5147.8 5182.6 5185.7 5760.8 5774.6 5783.7 5807.2 5814.5 6469.9 6521.4 6539.9 6550.7 6571.5 1757.7 1771.7 1784.9 1787.9 1797.1 1226.5 1241.9 1262.4 1278.9 1285.4 5935.5 5974.6 6040.2 6083.8 6094.9 6511.8 6585.7 6599.9 6602.3 6629.2 6041.9 6057.9 6122.6 6130.8 6222.0 3476.0 3510.1 3514.8 3543.4 3556.0 7030.3 7052.4 7091.2 7096.0 7127.5 6825.7 6917.5 6917.6 6924.0 6936.5 6881.5 6931.2 7005.9 7033.7 7052.2 6660.1 6723.0 6734.1 6782.2 6798.3 6636.7 6650.7 6696.6 6704.2 6719.7 6929.9 7042.7 7058.1 7060.2 7064.8 5024.2 5061.7 5067.8 5083.3 5120.7 6452.8 6637.7 6648.3 6653.3 6682.0 6159.7 6421.4 6429.7 6442.2 6497.6 6329.9 6356.6 6409.5 6479.0 6498.7 6318.9 6371.0 6372.4 6464.9 6479.9 6460.8 6462.6 6478.7 6540.4 6590.6 6306.5 6327.3 6381.1 6418.5 6465.9 11:49:24 INFO - PID 7399 | 11:49:24 INFO - PID 7399 | [#5] yui.html Cycles:180 Average:28342.50 Median:19449.82 stddev:41818.20 (215.0%) stddev-sans-first:41884.93 11:49:24 INFO - PID 7399 | Values: 947.8 988.0 990.2 991.6 1037.4 20031.5 20506.9 20520.9 20521.0 20535.3 15275.0 15297.3 15489.8 18502.0 18601.4 988.6 1018.5 1022.2 1024.3 1024.6 1035.0 1053.8 1105.7 1107.2 1108.8 1111.2 1113.8 1116.4 1116.4 1117.1 1110.4 1115.6 1119.1 1149.1 1179.9 807.6 816.7 822.6 823.1 825.0 20678.8 20764.7 20804.5 20876.8 20890.7 22274.9 23175.8 23420.9 23452.5 23465.4 15871.5 16767.9 16808.3 16823.7 16840.7 3977.2 4007.4 4009.4 4016.4 4017.1 154733.0 156921.0 158649.0 158797.0 162669.0 16984.2 17235.7 17531.3 17546.7 17905.4 31915.1 33001.2 33377.7 33555.0 35270.6 9013.8 9098.7 9165.0 9165.4 9182.5 4383.7 4517.9 4520.4 4527.9 4533.3 5772.9 6057.8 6096.5 6105.3 6157.8 1077.6 1092.3 1105.0 1108.8 1108.9 757.6 765.2 778.6 781.7 783.7 12026.8 12174.3 12414.9 13064.2 13428.7 716.0 719.3 726.4 736.3 737.6 5788.7 5876.6 5930.2 5959.8 6045.6 147521.0 148783.0 149935.3 149978.0 153669.2 121646.0 122025.4 124880.4 125536.0 128934.0 106065.5 107757.0 107924.5 109177.9 110191.0 13501.9 13879.4 13968.4 14354.6 14589.3 50018.5 50707.5 51181.7 52952.2 54419.2 82074.6 88164.0 88657.6 90480.5 91364.0 19516.2 20366.0 20402.3 20486.2 20666.8 19144.1 19375.7 19802.6 19884.3 21541.1 17984.6 18189.5 18704.5 19383.4 19615.6 17222.6 17538.6 17576.6 17691.8 17709.1 19636.9 20302.7 20431.0 20460.4 20982.1 12681.4 12701.0 12761.3 12809.2 13889.0 15405.8 15415.5 15740.5 15756.4 16429.3 11:49:24 INFO - PID 7399 | -------- Summary: end -------- 11:49:24 INFO - PID 7399 | 11:49:25 INFO - TEST-INFO | 7399: exit 0 11:49:25 INFO - TEST-OK | dromaeo_css | took 1107989ms 11:49:25 INFO - TEST-START | kraken 11:49:25 INFO - Initialising browser for kraken test... 11:49:25 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:43543/getInfo.html -profile /tmp/tmpG_cqbu/profile 11:49:25 INFO - TEST-INFO | started process 7772 (/builds/slave/test/build/application/firefox/firefox http://localhost:43543/getInfo.html) 11:49:30 INFO - TEST-INFO | 7772: exit 0 11:49:30 INFO - Browser initialized. 11:49:30 INFO - Running cycle 1/1 for kraken test... 11:49:30 INFO - Using env: {'DISPLAY': ':0', 11:49:30 INFO - 'HOME': '/home/cltbld', 11:49:30 INFO - 'JSGC_DISABLE_POISONING': '1', 11:49:30 INFO - 'LANG': 'en_US.UTF-8', 11:49:30 INFO - 'LANGUAGE': 'en_US:en', 11:49:30 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:49:30 INFO - 'LOGNAME': 'cltbld', 11:49:30 INFO - 'MAIL': '/var/mail/cltbld', 11:49:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:49:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:49:30 INFO - 'MOZ_CRASHREPORTER': '1', 11:49:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:30 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:49:30 INFO - 'MOZ_NO_REMOTE': '1', 11:49:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:49:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:49:30 INFO - 'NO_EM_RESTART': '1', 11:49:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:49:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:30 INFO - 'PWD': '/builds/slave/test', 11:49:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:49:30 INFO - 'RUST_BACKTRACE': 'full', 11:49:30 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:49:30 INFO - 'SHELL': '/bin/bash', 11:49:30 INFO - 'SHLVL': '1', 11:49:30 INFO - 'STYLO_FORCE_DISABLED': '1', 11:49:30 INFO - 'TERM': 'linux', 11:49:30 INFO - 'TMOUT': '86400', 11:49:30 INFO - 'USER': 'cltbld', 11:49:30 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1504808988.182962-1302296783', 11:49:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:30 INFO - '_': '/tools/buildbot/bin/python'} 11:49:30 INFO - TEST-INFO | started process 7972 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpG_cqbu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:49:31 INFO - PID 7972 | 11:49:31 INFO - PID 7972 | (/builds/slave/test/build/application/firefox/firefox:8022): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:49:31 INFO - PID 7972 | 11:49:42 INFO - PID 7972 | RSS: Main: 161845248 11:49:42 INFO - PID 7972 | 11:49:44 INFO - PID 7972 | Cycle 1(1): loaded http://localhost:43543/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43543/tests/kraken/driver.html?testName=audio-beat-detection) 11:49:45 INFO - PID 7972 | RSS: Main: 167723008 11:49:45 INFO - PID 7972 | 11:49:48 INFO - PID 7972 | Cycle 1(1): loaded http://localhost:43543/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43543/tests/kraken/driver.html?testName=audio-dft) 11:49:48 INFO - PID 7972 | RSS: Main: 168316928 11:49:48 INFO - PID 7972 | 11:49:51 INFO - PID 7972 | Cycle 1(1): loaded http://localhost:43543/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43543/tests/kraken/driver.html?testName=audio-fft) 11:49:52 INFO - PID 7972 | RSS: Main: 162234368 11:49:52 INFO - PID 7972 | 11:49:54 INFO - PID 7972 | Cycle 1(1): loaded http://localhost:43543/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43543/tests/kraken/driver.html?testName=audio-oscillator) 11:49:54 INFO - PID 7972 | RSS: Main: 163868672 11:49:54 INFO - PID 7972 | 11:49:56 INFO - PID 7972 | Cycle 1(1): loaded http://localhost:43543/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43543/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:49:57 INFO - PID 7972 | RSS: Main: 163573760 11:49:57 INFO - PID 7972 | 11:50:00 INFO - PID 7972 | Cycle 1(1): loaded http://localhost:43543/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43543/tests/kraken/driver.html?testName=imaging-darkroom) 11:50:01 INFO - PID 7972 | RSS: Main: 163856384 11:50:01 INFO - PID 7972 | 11:50:04 INFO - PID 7972 | Cycle 1(1): loaded http://localhost:43543/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43543/tests/kraken/driver.html?testName=imaging-desaturate) 11:50:05 INFO - PID 7972 | RSS: Main: 167063552 11:50:05 INFO - PID 7972 | 11:50:08 INFO - PID 7972 | Cycle 1(1): loaded http://localhost:43543/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43543/tests/kraken/driver.html?testName=json-parse-financial) 11:50:08 INFO - PID 7972 | RSS: Main: 167497728 11:50:08 INFO - PID 7972 | 11:50:10 INFO - PID 7972 | Cycle 1(1): loaded http://localhost:43543/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43543/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:50:10 INFO - PID 7972 | RSS: Main: 167165952 11:50:10 INFO - PID 7972 | 11:50:12 INFO - PID 7972 | Cycle 1(1): loaded http://localhost:43543/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43543/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:50:12 INFO - PID 7972 | RSS: Main: 167190528 11:50:12 INFO - PID 7972 | 11:50:14 INFO - PID 7972 | Cycle 1(1): loaded http://localhost:43543/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43543/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:50:15 INFO - PID 7972 | RSS: Main: 164044800 11:50:15 INFO - PID 7972 | 11:50:18 INFO - PID 7972 | Cycle 1(1): loaded http://localhost:43543/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43543/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:50:18 INFO - PID 7972 | RSS: Main: 163692544 11:50:18 INFO - PID 7972 | 11:50:21 INFO - PID 7972 | Cycle 1(1): loaded http://localhost:43543/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43543/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:50:22 INFO - PID 7972 | RSS: Main: 164605952 11:50:22 INFO - PID 7972 | 11:50:23 INFO - PID 7972 | Cycle 1(1): loaded http://localhost:43543/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43543/tests/kraken/driver.html?testName=ai-astar) 11:50:24 INFO - PID 7972 | RSS: Main: 166838272 11:50:24 INFO - PID 7972 | 11:50:24 INFO - PID 7972 | __start_tp_report 11:50:24 INFO - PID 7972 | _x_x_mozilla_page_load 11:50:24 INFO - PID 7972 | _x_x_mozilla_page_load_details 11:50:24 INFO - PID 7972 | |i|pagename|runs| 11:50:24 INFO - PID 7972 | |0;ai-astar;106;105;106;104;106;105;105;106;96;105 11:50:24 INFO - PID 7972 | |1;audio-beat-detection;123;113;115;116;113;110;139;114;113;115 11:50:24 INFO - PID 7972 | |2;audio-dft;163;163;164;164;164;163;162;163;166;166 11:50:24 INFO - PID 7972 | |3;audio-fft;73;73;74;73;73;74;73;73;73;71 11:50:24 INFO - PID 7972 | |4;audio-oscillator;79;78;78;79;76;79;78;78;78;79 11:50:24 INFO - PID 7972 | |5;imaging-gaussian-blur;113;114;113;113;113;113;114;114;116;114 11:50:24 INFO - PID 7972 | |6;imaging-darkroom;150;149;151;150;149;149;149;149;150;149 11:50:24 INFO - PID 7972 | |7;imaging-desaturate;94;95;93;95;94;94;95;95;95;94 11:50:24 INFO - PID 7972 | |8;json-parse-financial;45;44;43;42;43;43;42;42;53;45 11:50:24 INFO - PID 7972 | |9;json-stringify-tinderbox;38;39;38;38;38;39;39;39;39;39 11:50:24 INFO - PID 7972 | |10;stanford-crypto-aes;74;72;72;74;72;72;71;73;72;71 11:50:24 INFO - PID 7972 | |11;stanford-crypto-ccm;115;121;109;112;113;112;111;117;110;114 11:50:24 INFO - PID 7972 | |12;stanford-crypto-pbkdf2;159;152;152;153;152;153;154;168;157;144 11:50:24 INFO - PID 7972 | |13;stanford-crypto-sha256-iterative;63;59;61;59;58;59;58;62;62;58 11:50:24 INFO - PID 7972 | __end_tp_report 11:50:24 INFO - PID 7972 | __start_cc_report 11:50:24 INFO - PID 7972 | _x_x_mozilla_cycle_collect,888 11:50:24 INFO - PID 7972 | __end_cc_report 11:50:24 INFO - PID 7972 | __startTimestamp1504810223997__endTimestamp 11:50:24 INFO - PID 7972 | 11:50:24 INFO - PID 7972 | ------- Summary: start ------- 11:50:24 INFO - PID 7972 | Number of tests: 14 11:50:24 INFO - PID 7972 | 11:50:24 INFO - PID 7972 | [#0] ai-astar Cycles:10 Average:104.40 Median:106.00 stddev:3.03 (2.9%) stddev-sans-first:3.15 11:50:24 INFO - PID 7972 | Values: 106.0 105.0 106.0 104.0 106.0 105.0 105.0 106.0 96.0 105.0 11:50:24 INFO - PID 7972 | 11:50:24 INFO - PID 7972 | [#1] audio-beat-detection Cycles:10 Average:117.10 Median:115.00 stddev:8.40 (7.3%) stddev-sans-first:8.63 11:50:24 INFO - PID 7972 | Values: 123.0 113.0 115.0 116.0 113.0 110.0 139.0 114.0 113.0 115.0 11:50:24 INFO - PID 7972 | 11:50:24 INFO - PID 7972 | [#2] audio-dft Cycles:10 Average:163.80 Median:164.00 stddev:1.32 (0.8%) stddev-sans-first:1.36 11:50:24 INFO - PID 7972 | Values: 163.0 163.0 164.0 164.0 164.0 163.0 162.0 163.0 166.0 166.0 11:50:24 INFO - PID 7972 | 11:50:24 INFO - PID 7972 | [#3] audio-fft Cycles:10 Average:73.00 Median:73.00 stddev:0.82 (1.1%) stddev-sans-first:0.87 11:50:24 INFO - PID 7972 | Values: 73.0 73.0 74.0 73.0 73.0 74.0 73.0 73.0 73.0 71.0 11:50:24 INFO - PID 7972 | 11:50:24 INFO - PID 7972 | [#4] audio-oscillator Cycles:10 Average:78.20 Median:78.50 stddev:0.92 (1.2%) stddev-sans-first:0.93 11:50:24 INFO - PID 7972 | Values: 79.0 78.0 78.0 79.0 76.0 79.0 78.0 78.0 78.0 79.0 11:50:24 INFO - PID 7972 | 11:50:24 INFO - PID 7972 | [#5] imaging-gaussian-blur Cycles:10 Average:113.70 Median:114.00 stddev:0.95 (0.8%) stddev-sans-first:0.97 11:50:24 INFO - PID 7972 | Values: 113.0 114.0 113.0 113.0 113.0 113.0 114.0 114.0 116.0 114.0 11:50:24 INFO - PID 7972 | 11:50:24 INFO - PID 7972 | [#6] imaging-darkroom Cycles:10 Average:149.50 Median:149.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 11:50:24 INFO - PID 7972 | Values: 150.0 149.0 151.0 150.0 149.0 149.0 149.0 149.0 150.0 149.0 11:50:24 INFO - PID 7972 | 11:50:24 INFO - PID 7972 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 11:50:24 INFO - PID 7972 | Values: 94.0 95.0 93.0 95.0 94.0 94.0 95.0 95.0 95.0 94.0 11:50:24 INFO - PID 7972 | 11:50:24 INFO - PID 7972 | [#8] json-parse-financial Cycles:10 Average:44.20 Median:43.50 stddev:3.29 (7.6%) stddev-sans-first:3.48 11:50:24 INFO - PID 7972 | Values: 45.0 44.0 43.0 42.0 43.0 43.0 42.0 42.0 53.0 45.0 11:50:24 INFO - PID 7972 | 11:50:24 INFO - PID 7972 | [#9] json-stringify-tinderbox Cycles:10 Average:38.60 Median:39.00 stddev:0.52 (1.3%) stddev-sans-first:0.50 11:50:24 INFO - PID 7972 | Values: 38.0 39.0 38.0 38.0 38.0 39.0 39.0 39.0 39.0 39.0 11:50:24 INFO - PID 7972 | 11:50:24 INFO - PID 7972 | [#10] stanford-crypto-aes Cycles:10 Average:72.30 Median:72.00 stddev:1.06 (1.5%) stddev-sans-first:0.93 11:50:24 INFO - PID 7972 | Values: 74.0 72.0 72.0 74.0 72.0 72.0 71.0 73.0 72.0 71.0 11:50:24 INFO - PID 7972 | 11:50:24 INFO - PID 7972 | [#11] stanford-crypto-ccm Cycles:10 Average:113.40 Median:113.50 stddev:3.57 (3.1%) stddev-sans-first:3.73 11:50:24 INFO - PID 7972 | Values: 115.0 121.0 109.0 112.0 113.0 112.0 111.0 117.0 110.0 114.0 11:50:24 INFO - PID 7972 | 11:50:24 INFO - PID 7972 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.40 Median:153.50 stddev:6.17 (4.0%) stddev-sans-first:6.31 11:50:24 INFO - PID 7972 | Values: 159.0 152.0 152.0 153.0 152.0 153.0 154.0 168.0 157.0 144.0 11:50:24 INFO - PID 7972 | 11:50:24 INFO - PID 7972 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:59.90 Median:60.00 stddev:1.91 (3.2%) stddev-sans-first:1.67 11:50:24 INFO - PID 7972 | Values: 63.0 59.0 61.0 59.0 58.0 59.0 58.0 62.0 62.0 58.0 11:50:24 INFO - PID 7972 | -------- Summary: end -------- 11:50:24 INFO - PID 7972 | 11:50:24 INFO - PID 7972 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:50:24 INFO - TEST-INFO | 7972: exit 0 11:50:24 INFO - TEST-OK | kraken | took 59805ms 11:50:24 INFO - SUITE-END | took 1167s 11:50:25 INFO - Completed test suite (00:19:28) 11:50:25 INFO - javascript benchmark 11:50:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9097.06460426301, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3865.7873816940073, 3873.6513713765758, 3885.630865067819, 3891.922161556771, 3901.51231096113, 6174.475169610577, 6265.718042688079, 6266.279377871546, 6323.936760632392, 6347.555671103013, 6308.873822523547, 6351.90472142917, 6364.0, 6448.258450278219, 6461.386168314014, 797.29804551243, 5473.452654734515, 5665.093585026397, 5725.7995970141055, 5759.7696092156475, 5567.8886422271535, 5598.524125449342, 5625.915611265814, 5647.745851436695, 5667.886642267152, 5665.8583535411535, 5701.315842098933, 5745.569082318842, 5757.539396848263, 5759.68321742304, 5631.099024156116, 5648.15277708347, 5716.228309178249, 5718.628289161191, 5727.2268243786975, 5583.218349431083, 5611.438856114397, 5650.378458369576, 5687.232223649837, 5699.487046165865, 6330.936690633081, 6353.205849268841, 6354.9364506354805, 6375.617462952191, 6380.0, 6825.863482730318, 6830.453563714891, 6834.1457317835275, 6906.343897329796, 6921.0, 6868.278830722802, 6884.070650462174, 6953.165620125617, 6964.721411143548, 6966.9303306966785, 6331.461825744817, 6344.397282258178, 6382.106505089291, 6443.097966284724, 6463.127477790438, 7064.576125432491, 7078.858422831515, 7131.857362852714, 7141.000259963609, 7169.0, 6779.694913728894, 6814.046033555306, 6870.381665650116, 6876.484263680144, 6904.13698287714, 6870.828229294208, 6885.586864788129, 6941.826454338581, 6942.062821519131, 6962.1645402551, 6755.4257888080065, 6842.452603791685, 6893.965530172317, 6899.241083480813, 6906.792796216121, 6812.114425124702, 6826.419754320938, 6833.829154271183, 6924.861502770017, 6927.272636373209, 4934.407871055496, 4945.332380128637, 5001.074801161797, 5029.647924645313, 5037.093323201859, 4503.392042074343, 4536.841210557614, 4561.977190114028, 4581.518940511265, 4585.541445855454, 6199.969000155061, 6224.439800417894, 6228.501719862491, 6308.621482711052, 6310.211223597051, 6711.899321510181, 6768.187817461936, 6781.491388145909, 6793.762218322434, 6796.728130874809, 6193.876122477525, 6233.906491402633, 6247.781327653601, 6263.060540918898, 6285.937140628626, 5484.725763711798, 5553.0559804832465, 5555.972220138954, 5562.888742225133, 5576.219329293902, 7043.2604576518725, 7059.364657180879, 7090.964545177241, 7127.251638577978, 7135.250798666066, 6657.968014957786, 6750.3924646782025, 6791.966040169767, 6914.757983470555, 6920.792376228721, 7094.822629434306, 7115.395191408788, 7168.820779480346, 7172.533785303938, 7185.964070179615, 6746.898796517958, 6754.3921047106, 6836.042953986346, 6856.177258728785, 6856.965715171392, 6843.657817109224, 6859.142607174103, 6883.931160688329, 6930.896036559557, 6957.095577574883, 6670.166229221348, 6690.0, 6698.9665051676375, 6711.9328806713265, 6716.3955244028275, 6536.444402225674, 6710.228323742832, 6711.295313992156, 6711.832204194739, 6717.496187786033, 6618.305077966744, 6623.569467984566, 6651.534392592472, 6723.092382528296, 6723.663816809042, 6609.966950165219, 6651.16860392451, 6709.530332876652, 6784.7964561063245, 6790.966045169743, 6457.3865482779065, 6479.611223326616, 6489.967550162408, 6527.02094685801, 6576.145101136822], "value": 6227.057334857212, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [945.6264775413707, 956.0917128727708, 981.4552923127663, 1011.7976404719058, 1015.3400289811622, 44394.0, 45673.77163114184, 45783.54216457834, 45806.08387832245, 45947.0, 41682.37476437856, 41722.37416438756, 41918.79040604793, 42075.0, 42194.0, 7348.5958272295, 7449.1061072671355, 7484.401247900155, 7497.512661677001, 7534.397248220157, 7360.889586656204, 7412.814679632998, 7427.554346739213, 7433.553986760785, 7442.925570744304, 7970.402219833507, 8424.368172387065, 8424.368172387065, 8424.53665048422, 8451.57742112895, 7850.842983140363, 8301.128381519944, 8353.122922093153, 8377.706780262692, 8381.371397145209, 8114.63484143215, 8219.931408916862, 8228.753137405887, 8235.13531079234, 8235.876461853017, 40766.184676306606, 41210.587894120974, 41258.0, 41260.0, 41351.793241033905, 3691.335559599271, 3733.663970242691, 3736.9439458408146, 3745.7190710696805, 3750.1937083527173, 33954.151146221295, 34038.0, 34088.48867266968, 34187.145321366916, 34241.82879085613, 5185.55922746567, 5196.68819870809, 5211.218317252443, 5218.582513398919, 5219.530242278175, 231501.0, 236110.0, 236852.99999999828, 237194.0, 237390.0, 54147.0, 55262.72368638131, 56434.717826410604, 56462.15306770402, 56884.0, 56879.0, 57385.71307143437, 57388.713056435285, 57437.0, 57511.42488575145, 15196.468123615621, 15408.460703875535, 15459.690806183813, 15587.0, 15589.0, 12179.269243845398, 12261.203021803733, 12271.079669024859, 12273.631791046282, 12284.570040048735, 14936.551903442914, 15073.321700523284, 15114.0, 15156.393744250106, 15285.082895026335, 5853.0, 5937.554683398763, 5958.404159584094, 5980.790672326448, 6021.729022194012, 1077.8550684138665, 1088.3361149698678, 1094.1465656787718, 1114.8216285394299, 1115.4590023838432, 25893.223203303933, 26030.34924126912, 26109.347266318113, 26127.477450450886, 26200.60699089515, 1182.8580570331615, 1206.4631239098517, 1207.0946789907568, 1212.4240985531978, 1214.8056310990198, 13739.24434156111, 13749.243791591558, 13871.0, 13950.0, 14241.578931581656, 282670.0, 283901.0, 284856.0, 286259.0, 286894.0, 59557.0, 59827.0, 64211.35788642054, 64212.0, 64562.0, 1484.354305876947, 1516.105497756329, 1516.5071351810705, 1517.1428143099113, 1530.3343045775123, 30885.417968261903, 30898.845505772326, 31172.68827311698, 31369.372612547166, 31544.211394715316, 39820.2035959285, 39969.2006159881, 40119.39820902747, 40159.59840401675, 40209.0, 241536.0, 242497.0, 242706.0, 243095.0, 243487.0, 37822.0, 37960.62039379682, 38021.0, 39435.40846887356, 40309.0, 49798.25302620536, 49829.25256121089, 49917.0, 50202.246966294806, 50517.74741126271, 36557.817210913774, 36742.63257367392, 36835.447468287464, 37023.814880926504, 37164.25671486609, 36885.0, 36959.44560831536, 37036.81481592575, 37127.0, 37295.44056839095, 42764.14471710611, 43143.78428107839, 43329.0, 43483.0, 43679.34480982724, 36251.0, 36498.817505913365, 36982.44526332054, 37489.250214995, 37625.4356184652, 27171.456570868868, 27580.034698785446, 27728.168154955383, 27819.44361112726, 27890.30274243079], "value": 18927.045619610126, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [598.7011566269852, 606.8391876152818, 616.1220261127892, 617.7837756785126, 639.1946147853704, 23115.884420577895, 24001.79363260423, 24023.159189428374, 24145.63781543276, 24187.153449629266, 23908.760912390913, 24959.87520062397, 25671.48657026863, 25688.486230275383, 25708.74291257087, 6774.458043356544, 6836.6923488443135, 6851.725930962755, 6873.5875847449315, 6874.10636617239, 6570.770023049195, 6882.9311706883045, 6885.724571017154, 6901.516893817435, 6907.205671347784, 6814.795556133299, 6826.761063362784, 6831.180258369002, 6836.0, 6836.5556238844565, 6813.931860681429, 6822.931770682304, 6824.419924306415, 6825.965870170667, 6827.419669328113, 6357.17356743625, 6361.872762544724, 6366.554341196118, 6377.553571250014, 6381.872362552723, 28336.149915502567, 29065.854670726512, 30120.24699382511, 30252.336121513308, 30270.24324391886, 2249.4376405898524, 2289.473421113153, 2293.7706229377095, 2294.2314324701247, 2298.1267118495034, 20132.295369662137, 20719.8964005179, 20766.48083797902, 20779.272725454535, 20783.27258545959, 2510.2092840755104, 2602.778763805079, 2642.9867850660817, 2664.467106578692, 2670.0654770830247, 131881.34059329738, 138266.0, 152589.0, 160069.19965400215, 160807.1959640206, 15151.924240378949, 15806.36774529029, 16073.598160045858, 16155.919220403823, 16467.5883102921, 25201.0, 25340.74659253384, 25458.0, 25555.233342999738, 25575.360615984377, 9888.110070093726, 10028.69913902584, 10130.645427410005, 10225.0, 10289.3311934724, 9046.592903319366, 9128.634854605874, 9174.67888623895, 9216.170544651013, 9239.0, 9615.471149086867, 9787.0, 9816.987517558884, 9983.800323993479, 10098.14165795901, 2792.3298408381843, 2829.8302101873956, 2832.405194909051, 2965.6589492208673, 2996.865141068657, 1052.3633201912885, 1052.9631462898915, 1053.578568572577, 1058.9364638121738, 1063.2450959818616, 20748.58502829935, 20838.37484875456, 21291.68062479064, 21397.25109621187, 21598.568028639653, 1102.7904698107334, 1105.6019832860163, 1106.6569363497342, 1115.9107271418268, 1116.542217690743, 11690.064794816395, 11790.0, 11809.704757380963, 11827.231229970024, 11851.170418070824, 557329.0, 568137.0, 581422.0, 585312.0, 596481.0, 131320.0, 131899.0, 132077.0, 132289.33855330662, 134549.3272533631, 1212.9090318226167, 1261.9116661833766, 1300.90243231758, 1325.6884632111446, 1329.8404191496888, 22849.0, 22975.54048918979, 23083.192088276828, 23136.305910822703, 23153.76846231516, 61231.693841530505, 63697.363026369145, 65681.34318656943, 65853.67073164604, 66703.0, 79501.0, 79635.20364796279, 79925.0, 80183.59908200422, 81261.0, 15438.22808859575, 15720.056796592242, 15741.212939352758, 15766.132862692662, 15778.526644200692, 23335.41661458477, 23479.295621131394, 23745.52508949846, 23865.64201537013, 23995.64006539938, 19202.8079719201, 19276.710849337553, 19406.8059319405, 19553.60892782108, 19784.703229451858, 16164.595885102966, 17163.570910727332, 17175.227114779616, 17445.214965326846, 17491.33832285931, 17663.0, 19860.304889328803, 20197.293094741613, 20484.283050093174, 20674.793252067288, 15287.082775033534, 15287.541373758804, 15389.692206156038, 15427.922860385626, 15461.994970326892, 19379.612407752047, 19642.705359419906, 19850.90074549618, 19965.20139194416, 19969.001549922155], "value": 12818.720021156576, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1381.9101758385705, 1493.977590336145, 1497.3561368611493, 1500.1824005916774, 1504.653929596193, 17341.7398739019, 17863.28546858124, 17863.821361786377, 17881.7317740234, 17886.373976910796, 17235.482935511922, 17373.7393939091, 17468.563285917826, 17483.475495735118, 17485.56286092845, 2759.296379423244, 2827.9434411311763, 2834.370237113668, 2862.084133077416, 2863.6563612366544, 2770.8476033818133, 2790.037437084203, 2796.105246321178, 2805.1584524642626, 2807.3964097718986, 2680.9463810723773, 2796.846173460459, 2898.666653334862, 2899.072296865004, 2900.898468553601, 2890.9132726018042, 2892.2624730693747, 2916.6791652918164, 2939.7501212396865, 2939.7795165362577, 2575.085844525185, 2791.260316016257, 2793.1480898326004, 2794.5109605818902, 2796.3568379272883, 16896.746548801777, 17020.82979170205, 17034.914825425793, 17047.48857534276, 17072.48782536526, 8240.793980150484, 8561.529115898624, 8561.785955351104, 8563.058063612998, 8567.82864342716, 5242.0826355388035, 5377.220303056074, 5475.123980163155, 5494.835154945358, 5518.061929471999, 1959.4611481842464, 1966.8426525877896, 1968.3170888889936, 1997.8301844343248, 2033.3899830051073, 30193.396132077454, 30445.0, 30446.54330185049, 30461.543076853864, 30526.84736576325, 7030.156381234285, 7121.89317160243, 7136.607486588184, 7234.131904171533, 7242.0, 19020.144093515824, 19030.33393831209, 19053.904730476257, 19057.80942190588, 19108.617827643648, 8044.637991290406, 8171.937648105708, 8247.917520824714, 8254.380921430917, 8265.8346833063, 7514.211007844097, 7545.886811697829, 7556.58438785872, 7701.807454813675, 7731.226877312224, 5375.650582712189, 5567.582431317667, 5600.747966341524, 5636.802711905064, 5874.206982057453, 1613.5482065021579, 1617.4824056302107, 1620.6375104460924, 1636.746304322832, 1646.4978181654471, 940.8917974432891, 969.5830792759182, 974.02110878568, 985.1232403161192, 1003.6035765872585, 9227.677031304007, 9368.156865882103, 9507.619695212252, 9539.713808585753, 9601.135897769234, 1032.9741756456149, 1052.7894421115807, 1056.3397876327294, 1060.3266925502362, 1065.1851333729703, 6361.4592759615025, 6452.387023232879, 6701.798946031627, 6781.525293229525, 6823.931760682429, 25393.61909571358, 25614.487710245692, 25619.487610248063, 25656.0, 25913.481730365664, 24289.149879754124, 25564.74435255661, 25610.743892561208, 25732.0, 25791.0, 11461.942690286494, 11616.477258523386, 11940.88059119415, 11996.280223186637, 12006.399680015964, 9728.513574321398, 10201.846972295272, 10210.489475526045, 10293.691189264335, 10377.688669339932, 20432.489187770425, 21060.04384804012, 21381.144754209658, 21469.141234350453, 22131.77868221297, 21700.240491582717, 22207.666884996415, 22303.888480557493, 22662.773372266725, 22667.206647767907, 13213.141145825875, 13704.0, 13762.311884405939, 13776.793348099987, 13780.310984450536, 14747.778783318045, 15072.095674259579, 15170.469033583771, 15199.392024318904, 15206.08763474195, 12574.182678125893, 12633.557825476431, 12645.0, 12741.299228542148, 12767.553135640208, 12122.333271670142, 12298.692532686755, 12313.569025084438, 12561.371931403575, 12750.48998040068, 10688.786224275316, 11076.612318568812, 11086.889131108908, 11169.497372618414, 11173.664790056311, 7880.448368614142, 8037.919620803951, 8038.276555110068, 8124.959375203086, 8206.384521160817, 7986.8801967971685, 8012.118666946748, 8147.470414423044, 8164.387670924586, 8189.50862948225], "value": 7368.470860554907, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [543.2910052381643, 554.5618961020792, 568.9402612725664, 571.7798647520704, 578.6383510306059, 6065.696715164247, 6169.1363209150695, 6181.721822517986, 6228.813135605939, 6271.247450305964, 6018.608790428619, 6093.634381937087, 6110.572259941806, 6116.694165291739, 6141.477974372184, 4838.395200599925, 4851.22380419133, 4922.93236840527, 4929.3591833061655, 4936.901261974758, 4802.35168252285, 4853.538913803183, 4856.854294371157, 4883.267509873512, 4926.408830940292, 4774.331593576902, 4811.78346974387, 4860.586850117745, 4868.269759536062, 4878.658493905428, 4815.590674792612, 4822.614190864722, 4867.342908707315, 4882.316475693406, 4903.975480122613, 4387.561243875619, 4408.779561021968, 4420.359047938063, 4443.755593442359, 4448.687637147017, 6059.606125601822, 6099.48154406876, 6102.26772787264, 6142.293636231846, 6176.536759743038, 5686.857828554278, 5716.57125715573, 5725.110713464588, 5794.391588883191, 5796.797112101056, 6414.198225221848, 6477.935220647781, 6501.317361677003, 6506.446952009038, 6587.80236592903, 4934.136526107916, 4937.629677774145, 4961.8511444656715, 4966.106100901836, 4999.975000124976, 6467.870642587169, 6578.80263592093, 6672.899906501407, 6689.521448846621, 6733.124693789776, 5046.21783623539, 5052.9747351263, 5059.595232381401, 5081.796728130834, 5110.105731496973, 5121.2574176744165, 5139.0, 5147.794088236504, 5182.585393168538, 5185.714785686823, 5760.798372057042, 5774.595778295479, 5783.710814459344, 5807.216025836458, 5814.534837213013, 6469.900116980125, 6521.424037505159, 6539.869202616016, 6550.737970481223, 6571.507136964747, 1757.6641752268367, 1771.6722406354866, 1784.9107544622716, 1787.883787553805, 1797.0834874213983, 1226.4547061293308, 1241.9130660853652, 1262.4003598290738, 1278.8721127887136, 1285.3765923527083, 5935.465808077293, 5974.551908606872, 6040.154378387029, 6083.756649733961, 6094.878102437927, 6511.837204069841, 6585.6707164641575, 6599.901001484982, 6602.2737498875085, 6629.204495460575, 6041.879162416727, 6057.878842423215, 6122.622409957724, 6130.754769809247, 6221.96889015552, 3475.965240347615, 3510.14001569612, 3514.753967222321, 3543.4153364695053, 3555.982220088883, 7030.3321184487395, 7052.435805135577, 7091.219965803757, 7095.964520177469, 7127.5010749248095, 6825.726970921207, 6917.51577389588, 6917.619530925847, 6923.9653801730665, 6936.4797640177185, 6881.483888708367, 6931.2375638679705, 7005.894911576331, 7033.659011969376, 7052.224255332012, 6660.134182556237, 6722.999815110002, 6734.107655801174, 6782.1861376635115, 6798.314665707117, 6636.668166591555, 6650.700718467584, 6696.59820410777, 6704.229013663491, 6719.664016799043, 6929.861402772017, 7042.6759169472925, 7058.082449281561, 7060.188078371053, 7064.788056358318, 5024.171011783015, 5061.6962982221185, 5067.847964561069, 5083.262926875656, 5120.667156634807, 6452.806415807533, 6637.738829622356, 6648.301928297459, 6653.334666533308, 6681.966590167018, 6159.6612186330185, 6421.422072013541, 6429.678516074271, 6442.194725659293, 6497.610143391412, 6329.936700632935, 6356.618602883842, 6409.4937689641965, 6479.023897711243, 6498.707558159799, 6318.873622527615, 6371.0, 6372.362763723776, 6464.896849512166, 6479.902801457888, 6460.804751121058, 6462.644554549545, 6478.708458119301, 6540.411362977355, 6590.637514936724, 6306.4639505642535, 6327.3356297589935, 6381.149466654804, 6418.4865210783955, 6465.935340646722], "value": 5099.174956453427, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [947.83412902742, 987.9604815807368, 990.2424645146461, 991.6281394477066, 1037.3879411147425, 20031.499212519677, 20506.897465512688, 20520.897395513002, 20521.0, 20535.28126515572, 15275.0, 15297.311620977054, 15489.84510154898, 18502.0, 18601.441956741284, 988.5650313861913, 1018.4805749067973, 1022.2435397805607, 1024.2522958240488, 1024.5645600619744, 1034.9793004139913, 1053.8313869780836, 1105.6738262212666, 1107.1530279336314, 1108.8004159251332, 1111.1721767283386, 1113.8162203236457, 1116.3971455414066, 1116.447358557511, 1117.123058399157, 1110.4114819145825, 1115.5872327238892, 1119.1270808769173, 1149.1438878035917, 1179.9351035693032, 807.6083099696642, 816.6651672814177, 822.5722624235424, 823.0987069159261, 825.0099880143791, 20678.793212067838, 20764.68852967207, 20804.47988800277, 20876.791232087635, 20890.686639700416, 22274.888625556767, 23175.76824231753, 23420.88289558541, 23452.530949380918, 23465.41336466585, 15871.52385428439, 16767.91616041924, 16808.32766689331, 16823.663526729397, 16840.663186736318, 3977.164795392971, 4007.3788562772816, 4009.3585026395926, 4016.4176194451643, 4017.055991841915, 154733.0, 156921.0, 158649.0, 158797.0, 162669.0, 16984.235709393106, 17235.74146387805, 17531.29874805019, 17546.736798948026, 17905.37331193428, 31915.138130380765, 33001.17497062593, 33377.66622333794, 33554.99335019953, 35270.64729352674, 9013.819723605491, 9098.727038188865, 9165.0, 9165.358424910326, 9182.540872956326, 4383.715058521186, 4517.887052823706, 4520.412346394947, 4527.864164075083, 4533.274676051816, 5772.884542309131, 6057.757689692363, 6096.451319381277, 6105.26736791579, 6157.753689852445, 1077.5905156040653, 1092.3118435385657, 1105.038616403718, 1108.7616162525096, 1108.9445527723742, 757.5909009135005, 765.223298352173, 778.622368151446, 781.675604624086, 783.7217787685404, 12026.759464810655, 12174.269543827399, 12414.875851241553, 13064.150830196197, 13428.724271194222, 715.9856802863914, 719.3489891648067, 726.4116065986568, 736.2821249281907, 737.5685224143829, 5788.739506722208, 5876.559258055578, 5930.169776231331, 5959.791407300723, 6045.637261764308, 147521.0, 148783.0, 149935.2503237477, 149978.0, 153669.23165384325, 121646.0, 122025.38987305007, 124880.37559812143, 125536.0, 128934.0, 106065.46967265115, 107757.0, 107924.46037769761, 109177.90822091837, 110191.0, 13501.932490337878, 13879.444822207402, 13968.441262349392, 14354.641133971734, 14589.270536473347, 50018.499815001385, 50707.49292507028, 51181.7440912793, 52952.20571691351, 54419.18371224514, 82074.58962705387, 88164.0, 88657.55671221603, 90480.54759726423, 91364.0, 19516.21935122579, 20366.0, 20402.28591999273, 20486.18055277772, 20666.793332066485, 19144.138513766637, 19375.709364359263, 19802.60394792125, 19884.304049358205, 21541.138354465646, 17984.550386239924, 18189.545261368043, 18704.53238669044, 19383.4184974451, 19615.60768784645, 17222.569435764206, 17538.649227015132, 17576.56058598545, 17691.823081769016, 17709.114544272994, 19636.90181549083, 20302.665193502937, 20431.0, 20460.38618841437, 20982.055807489003, 12681.429335679732, 12701.0, 12761.298128603015, 12809.23144611289, 13889.0, 15405.845941540889, 15415.460458883885, 15740.527784166494, 15756.369745210523, 16429.342826286815], "value": 9983.717953221338, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1376.9000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 105.0, 106.0, 104.0, 106.0, 105.0, 105.0, 106.0, 96.0, 105.0], "value": 104.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 113.0, 115.0, 116.0, 113.0, 110.0, 139.0, 114.0, 113.0, 115.0], "value": 117.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 164.0, 164.0, 164.0, 163.0, 162.0, 163.0, 166.0, 166.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 74.0, 73.0, 73.0, 74.0, 73.0, 73.0, 73.0, 71.0], "value": 73.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 78.0, 79.0, 76.0, 79.0, 78.0, 78.0, 78.0, 79.0], "value": 78.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 113.0, 113.0, 113.0, 113.0, 114.0, 114.0, 116.0, 114.0], "value": 113.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 149.0, 151.0, 150.0, 149.0, 149.0, 149.0, 149.0, 150.0, 149.0], "value": 149.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 93.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 94.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [45.0, 44.0, 43.0, 42.0, 43.0, 43.0, 42.0, 42.0, 53.0, 45.0], "value": 44.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 39.0, 38.0, 38.0, 38.0, 39.0, 39.0, 39.0, 39.0, 39.0], "value": 38.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 72.0, 72.0, 74.0, 72.0, 72.0, 71.0, 73.0, 72.0, 71.0], "value": 72.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 121.0, 109.0, 112.0, 113.0, 112.0, 111.0, 117.0, 110.0, 114.0], "value": 113.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 152.0, 152.0, 153.0, 152.0, 153.0, 154.0, 168.0, 157.0, 144.0], "value": 154.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 59.0, 61.0, 59.0, 58.0, 59.0, 58.0, 62.0, 62.0, 58.0], "value": 59.9, "unit": "score"}]}]} 11:50:25 INFO - Return code: 0 11:50:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:50:25 INFO - # TBPL SUCCESS # 11:50:25 INFO - Running post-action listener: _package_coverage_data 11:50:25 INFO - Running post-action listener: _resource_record_post_action 11:50:25 INFO - [mozharness: 2017-09-07 18:50:25.277729Z] Finished run-tests step (success) 11:50:25 INFO - Running post-run listener: _resource_record_post_run 11:50:25 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 0; Write bytes: 386764800; Read time: 0; Write time: 254700 11:50:25 INFO - TinderboxPrint: CPU usage
13.1% 11:50:25 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 11:50:25 INFO - TinderboxPrint: I/O write bytes / time
386,764,800 / 254,700 11:50:25 INFO - TinderboxPrint: CPU idle
8,211.7 (86.9%) 11:50:25 INFO - TinderboxPrint: CPU user
1,184.5 (12.5%) 11:50:25 INFO - TinderboxPrint: Swap in / out
0 / 0 11:50:25 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 99962880; Read time: 0; Write time: 83828 11:50:25 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:50:25 INFO - run-tests - Wall time: 1169s; CPU: 13.0%; Read bytes: 0; Write bytes: 286801920; Read time: 0; Write time: 170872 11:50:25 INFO - Running post-run listener: _upload_blobber_files 11:50:25 INFO - Blob upload gear active. 11:50:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:50:25 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 11:50:25 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'] 11:50:25 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 11:50:26 INFO - (blobuploader) - INFO - Open directory for files ... 11:50:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:50:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:50:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:50:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:50:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:50:29 INFO - (blobuploader) - INFO - Done attempting. 11:50:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 11:50:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:50:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:50:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 11:50:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:50:30 INFO - (blobuploader) - INFO - Done attempting. 11:50:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 11:50:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:50:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:50:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 11:50:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:50:31 INFO - (blobuploader) - INFO - Done attempting. 11:50:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:50:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:50:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:50:32 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:50:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:50:32 INFO - (blobuploader) - INFO - Done attempting. 11:50:32 INFO - (blobuploader) - INFO - Iteration through files over. 11:50:32 INFO - Return code: 0 11:50:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:50:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:50:32 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7149e6caeb5c98576449efe210bd57ac7caf0a73a254e37412773e251e80e0b9802db658dae15f2ee2968520025aac694230ee08d3939fba71651bad33440776", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6cc7c44c3323986fa2a6a718e9204363d35e1e7647b2aec16176340fd0f73a1b1fa1f301196f10c75c46da1b67ed5f778c18fbce05127860d16d3b1940fcbbce", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c56591ed0aba2bc2ad016c73eb3f6c1eb2899203317915830b63bb69eeec6131be260d012f693557378aa10839636e5b2fa9cfd9cf324bdb638c5ba8b56f8153", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5c8df09abc444acfe3bdc54c70b22886192f1ab8601fb0399f0fe19714b566e55174de4a68ee017c3c77bba9b1bf3517dd490b6d3e41a91a2b793fed626b0c8e"} 11:50:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:50:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:50:32 INFO - Contents: 11:50:32 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7149e6caeb5c98576449efe210bd57ac7caf0a73a254e37412773e251e80e0b9802db658dae15f2ee2968520025aac694230ee08d3939fba71651bad33440776", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6cc7c44c3323986fa2a6a718e9204363d35e1e7647b2aec16176340fd0f73a1b1fa1f301196f10c75c46da1b67ed5f778c18fbce05127860d16d3b1940fcbbce", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c56591ed0aba2bc2ad016c73eb3f6c1eb2899203317915830b63bb69eeec6131be260d012f693557378aa10839636e5b2fa9cfd9cf324bdb638c5ba8b56f8153", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5c8df09abc444acfe3bdc54c70b22886192f1ab8601fb0399f0fe19714b566e55174de4a68ee017c3c77bba9b1bf3517dd490b6d3e41a91a2b793fed626b0c8e"} 11:50:32 INFO - Running post-run listener: copy_logs_to_upload_dir 11:50:32 INFO - Copying logs to upload dir... 11:50:32 INFO - mkdir: /builds/slave/test/build/upload/logs 11:50:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.887245 ========= master_lag: -0.14 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2017-09-07 11:50:32.667531) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-07 11:50:32.671220) ========= 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: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=199fb4c72b90437b990b419b000001c5-1504808988.182962-1302296783 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7149e6caeb5c98576449efe210bd57ac7caf0a73a254e37412773e251e80e0b9802db658dae15f2ee2968520025aac694230ee08d3939fba71651bad33440776", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6cc7c44c3323986fa2a6a718e9204363d35e1e7647b2aec16176340fd0f73a1b1fa1f301196f10c75c46da1b67ed5f778c18fbce05127860d16d3b1940fcbbce", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c56591ed0aba2bc2ad016c73eb3f6c1eb2899203317915830b63bb69eeec6131be260d012f693557378aa10839636e5b2fa9cfd9cf324bdb638c5ba8b56f8153", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5c8df09abc444acfe3bdc54c70b22886192f1ab8601fb0399f0fe19714b566e55174de4a68ee017c3c77bba9b1bf3517dd490b6d3e41a91a2b793fed626b0c8e"} build_url:https://queue.taskcluster.net/v1/task/IGNMaOSuRLejLW-8IRhPzg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011447 build_url: 'https://queue.taskcluster.net/v1/task/IGNMaOSuRLejLW-8IRhPzg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7149e6caeb5c98576449efe210bd57ac7caf0a73a254e37412773e251e80e0b9802db658dae15f2ee2968520025aac694230ee08d3939fba71651bad33440776", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6cc7c44c3323986fa2a6a718e9204363d35e1e7647b2aec16176340fd0f73a1b1fa1f301196f10c75c46da1b67ed5f778c18fbce05127860d16d3b1940fcbbce", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c56591ed0aba2bc2ad016c73eb3f6c1eb2899203317915830b63bb69eeec6131be260d012f693557378aa10839636e5b2fa9cfd9cf324bdb638c5ba8b56f8153", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5c8df09abc444acfe3bdc54c70b22886192f1ab8601fb0399f0fe19714b566e55174de4a68ee017c3c77bba9b1bf3517dd490b6d3e41a91a2b793fed626b0c8e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-07 11:50:32.703109) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 11:50:32.703531) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=199fb4c72b90437b990b419b000001c5-1504808988.182962-1302296783 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004523 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 11:50:32.787514) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-07 11:50:32.787833) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-07 11:50:32.788118) ========= ========= Total master_lag: 0.03 =========