builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-007 starttime: 1504807106.83 results: success (0) revision: 3c96d611ebd67fc219d22bcb476a72412c76f6c7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-07 10:58:26.832972) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-07 10:58:26.833477) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-07 10:58:26.833750) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-07 10:58:26.850811) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 10:58:26.851069) ========= 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=923d835db2ba3686ebe126b700000192-1504807105.814051-1321574702 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-07 10:58:26-- 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% 46.2M=0s 2017-09-07 10:58:27 (46.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.127084 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 10:58:26.994800) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 10:58:26.995103) ========= 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=923d835db2ba3686ebe126b700000192-1504807105.814051-1321574702 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017454 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 10:58:27.048129) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 10:58:27.051473) ========= 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=923d835db2ba3686ebe126b700000192-1504807105.814051-1321574702 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-07 10:58:27,224 truncating revision to first 12 chars 2017-09-07 10:58:27,224 Setting DEBUG logging. 2017-09-07 10:58:27,224 attempt 1/10 2017-09-07 10:58:27,224 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 10:58:27,609 unpacking tar archive at: mozilla-central-3c96d611ebd6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.705826 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 10:58:27.773198) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-07 10:58:27.776521) ========= script_repo_revision: 3c96d611ebd67fc219d22bcb476a72412c76f6c7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-07 10:58:27.776897) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-07 10:58:27.777169) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-07 10:58:27.790464) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-09-07 10:58:27.790747) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-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-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=923d835db2ba3686ebe126b700000192-1504807105.814051-1321574702 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:58:28 INFO - MultiFileLogger online at 20170907 10:58:28 in /builds/slave/test 10:58:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 10:58:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:58:28 INFO - {'append_to_log': False, 10:58:28 INFO - 'base_work_dir': '/builds/slave/test', 10:58:28 INFO - 'blob_upload_branch': 'Firefox', 10:58:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:58:28 INFO - 'branch': 'Firefox', 10:58:28 INFO - 'buildbot_json_path': 'buildprops.json', 10:58:28 INFO - 'code_coverage': False, 10:58:28 INFO - 'config_files': ('talos/linux_config.py',), 10:58:28 INFO - 'default_actions': ('clobber', 10:58:28 INFO - 'read-buildbot-config', 10:58:28 INFO - 'download-and-extract', 10:58:28 INFO - 'populate-webroot', 10:58:28 INFO - 'create-virtualenv', 10:58:28 INFO - 'install', 10:58:28 INFO - 'setup-mitmproxy', 10:58:28 INFO - 'run-tests'), 10:58:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:58:28 INFO - 'disable_ccov_upload': False, 10:58:28 INFO - 'disable_stylo': False, 10:58:28 INFO - 'download_minidump_stackwalk': True, 10:58:28 INFO - 'download_symbols': 'ondemand', 10:58:28 INFO - 'enable_stylo': False, 10:58:28 INFO - 'enable_webrender': False, 10:58:28 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 10:58:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:58:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:58:28 INFO - 'gecko_profile': False, 10:58:28 INFO - 'gecko_profile_interval': 0, 10:58:28 INFO - 'installer_path': 'installer.exe', 10:58:28 INFO - 'log_level': 'info', 10:58:28 INFO - 'log_name': 'talos', 10:58:28 INFO - 'log_to_console': True, 10:58:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:58:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:58:28 INFO - 'opt_config_files': (), 10:58:28 INFO - 'pip_index': False, 10:58:28 INFO - 'suite': 'dromaeojs-e10s', 10:58:28 INFO - 'system_bits': '32', 10:58:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:58:28 INFO - 'title': 'talos-linux64-ix-007', 10:58:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:58:28 INFO - 'use_talos_json': True, 10:58:28 INFO - 'verify': 'False', 10:58:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:58:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:58:28 INFO - 'work_dir': 'build'} 10:58:28 INFO - [mozharness: 2017-09-07 17:58:28.105393Z] Running clobber step. 10:58:28 INFO - Running pre-action listener: _resource_record_pre_action 10:58:28 INFO - Running main action method: clobber 10:58:28 INFO - rmtree: /builds/slave/test/build 10:58:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:58:29 INFO - Running post-action listener: _resource_record_post_action 10:58:29 INFO - [mozharness: 2017-09-07 17:58:29.117355Z] Finished clobber step (success) 10:58:29 INFO - [mozharness: 2017-09-07 17:58:29.117452Z] Running read-buildbot-config step. 10:58:29 INFO - Running pre-action listener: _resource_record_pre_action 10:58:29 INFO - Running main action method: read_buildbot_config 10:58:29 INFO - Using buildbot properties: 10:58:29 INFO - { 10:58:29 INFO - "project": "", 10:58:29 INFO - "product": "firefox", 10:58:29 INFO - "who": "ffxbld@noreply.mozilla.org", 10:58:29 INFO - "installer_path": "public/build/target.tar.bz2", 10:58:29 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 10:58:29 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 10:58:29 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 10:58:29 INFO - "stage_platform": "linux64-stylosequential", 10:58:29 INFO - "basedir": "/builds/slave/test", 10:58:29 INFO - "buildnumber": 64, 10:58:29 INFO - "platform": "ubuntu64_hw_styloseq", 10:58:29 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:58:29 INFO - "slavebuilddir": "test", 10:58:29 INFO - "taskId": "H7lMqCTOQW-ceJP5b5QkAQ", 10:58:29 INFO - "branch": "mozilla-central", 10:58:29 INFO - "script_repo_revision": "production", 10:58:29 INFO - "revision": "3c96d611ebd67fc219d22bcb476a72412c76f6c7", 10:58:29 INFO - "slavename": "talos-linux64-ix-007", 10:58:29 INFO - "repo_path": "mozilla-central" 10:58:29 INFO - } 10:58:29 INFO - Finding installer, test and symbols from parent task. 10:58:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/H7lMqCTOQW-ceJP5b5QkAQ'}, attempt #1 10:58:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/H7lMqCTOQW-ceJP5b5QkAQ'}, attempt #1 10:58:30 INFO - Task dependencies: ErCwGB7lSTS6L7N4qpQiKw 10:58:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw'}, attempt #1 10:58:30 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.tar.bz2 10:58:30 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.test_packages.json 10:58:30 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.crashreporter-symbols.zip 10:58:30 INFO - Running post-action listener: _resource_record_post_action 10:58:30 INFO - [mozharness: 2017-09-07 17:58:30.521582Z] Finished read-buildbot-config step (success) 10:58:30 INFO - [mozharness: 2017-09-07 17:58:30.521797Z] Running download-and-extract step. 10:58:30 INFO - Running pre-action listener: _resource_record_pre_action 10:58:30 INFO - Running main action method: download_and_extract 10:58:30 INFO - mkdir: /builds/slave/test/build/tests 10:58:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:58:30 INFO - trying https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.test_packages.json 10:58:30 INFO - Downloading https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 10:58:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 10:58:31 INFO - Downloaded 989 bytes. 10:58:31 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 10:58:31 INFO - Using the following test package requirements: 10:58:31 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 10:58:31 INFO - u'common': [u'target.common.tests.zip'], 10:58:31 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 10:58:31 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 10:58:31 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 10:58:31 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 10:58:31 INFO - u'mozbase': [u'target.common.tests.zip'], 10:58:31 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 10:58:31 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 10:58:31 INFO - u'web-platform': [u'target.common.tests.zip', 10:58:31 INFO - u'target.web-platform.tests.tar.gz'], 10:58:31 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 10:58:31 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 10:58:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.common.tests.zip 10:58:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:58:31 INFO - Fetch https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.common.tests.zip into memory 10:58:32 INFO - Content-Length response header: 55021210 10:58:32 INFO - Bytes received: 55021210 10:58:43 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 10:58:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.common.tests.zip 10:58:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:58:43 INFO - Fetch https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.common.tests.zip into memory 10:58:44 INFO - Content-Length response header: 55021210 10:58:44 INFO - Bytes received: 55021210 10:58:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.talos.tests.zip 10:58:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 10:58:56 INFO - Fetch https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.talos.tests.zip into memory 10:58:57 INFO - Content-Length response header: 14496665 10:58:57 INFO - Bytes received: 14496665 10:58:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:58:57 INFO - trying https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.tar.bz2 10:58:57 INFO - Downloading https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 10:58:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 10:58:58 INFO - Downloaded 62754681 bytes. 10:58:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.tar.bz2 10:58:58 INFO - mkdir: /builds/slave/test/properties 10:58:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:58:58 INFO - Writing to file /builds/slave/test/properties/build_url 10:58:58 INFO - Contents: 10:58:58 INFO - build_url:https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.tar.bz2 10:58:58 INFO - Running post-action listener: _resource_record_post_action 10:58:58 INFO - Running post-action listener: find_tests_for_verification 10:58:58 INFO - Running post-action listener: set_extra_try_arguments 10:58:58 INFO - [mozharness: 2017-09-07 17:58:58.547251Z] Finished download-and-extract step (success) 10:58:58 INFO - [mozharness: 2017-09-07 17:58:58.547348Z] Running populate-webroot step. 10:58:58 INFO - Running pre-action listener: _resource_record_pre_action 10:58:58 INFO - Running main action method: populate_webroot 10:58:58 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:58:58 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 10:58:58 INFO - 'tests': ['tresize', 10:58:58 INFO - 'tcanvasmark']}, 10:58:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:58:58 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 10:58:58 INFO - 'tests': ['dromaeo_css', 10:58:58 INFO - 'kraken']}, 10:58:58 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:58:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:58:58 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 10:58:58 INFO - 'talos_options': ['--disable-stylo'], 10:58:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:58:58 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:58:58 INFO - 'tests': ['damp', 'tps']}, 10:58:58 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 10:58:58 INFO - 'talos_options': ['--disable-stylo'], 10:58:58 INFO - 'tests': ['damp', 'tps']}, 10:58:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:58:58 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 10:58:58 INFO - 'tests': ['dromaeo_dom']}, 10:58:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 10:58:58 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 10:58:58 INFO - 'tests': ['basic_compositor_video', 10:58:58 INFO - 'glvideo']}, 10:58:58 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 10:58:58 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 10:58:58 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 10:58:58 INFO - 'talos_options': ['--disable-stylo'], 10:58:58 INFO - 'tests': ['ts_paint_webext', 10:58:58 INFO - 'tp5o_webext']}, 10:58:58 INFO - 'other-e10s': {'tests': ['a11yr', 10:58:58 INFO - 'ts_paint', 10:58:58 INFO - 'tpaint', 10:58:58 INFO - 'sessionrestore', 10:58:58 INFO - 'sessionrestore_many_windows', 10:58:58 INFO - 'sessionrestore_no_auto_restore', 10:58:58 INFO - 'tabpaint']}, 10:58:58 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 10:58:58 INFO - 'tests': ['a11yr', 10:58:58 INFO - 'ts_paint', 10:58:58 INFO - 'tpaint', 10:58:58 INFO - 'sessionrestore', 10:58:58 INFO - 'sessionrestore_many_windows', 10:58:58 INFO - 'sessionrestore_no_auto_restore', 10:58:58 INFO - 'tabpaint']}, 10:58:58 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 10:58:58 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 10:58:58 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 10:58:58 INFO - 'tests': ['bloom_basic_singleton']}, 10:58:58 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 10:58:58 INFO - 'tests': ['bloom_basic']}, 10:58:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:58:58 INFO - 'tsvgr_opacity', 10:58:58 INFO - 'tart', 10:58:58 INFO - 'tscrollx', 10:58:58 INFO - 'tsvg_static']}, 10:58:58 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 10:58:58 INFO - 'tests': ['tsvgx', 10:58:58 INFO - 'tsvgr_opacity', 10:58:58 INFO - 'tart', 10:58:58 INFO - 'tscrollx', 10:58:58 INFO - 'tsvg_static']}, 10:58:58 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:58:58 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 10:58:58 INFO - 'talos_options': ['--disable-stylo'], 10:58:58 INFO - 'tests': ['tp5o']}, 10:58:58 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 10:58:58 INFO - 'talos_options': ['--mitmproxy', 10:58:58 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 10:58:58 INFO - '--firstNonBlankPaint'], 10:58:58 INFO - 'tests': ['tp6_google', 10:58:58 INFO - 'tp6_youtube', 10:58:58 INFO - 'tp6_amazon', 10:58:58 INFO - 'tp6_facebook']}, 10:58:58 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 10:58:58 INFO - 'talos_options': ['--disable-stylo', 10:58:58 INFO - '--mitmproxy', 10:58:58 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 10:58:58 INFO - '--firstNonBlankPaint'], 10:58:58 INFO - 'tests': ['tp6_google', 10:58:58 INFO - 'tp6_youtube', 10:58:58 INFO - 'tp6_amazon', 10:58:58 INFO - 'tp6_facebook']}, 10:58:58 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 10:58:58 INFO - 'talos_options': ['--stylo-threads=1', 10:58:58 INFO - '--mitmproxy', 10:58:58 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 10:58:58 INFO - '--firstNonBlankPaint'], 10:58:58 INFO - 'tests': ['tp6_google', 10:58:58 INFO - 'tp6_youtube', 10:58:58 INFO - 'tp6_amazon', 10:58:58 INFO - 'tp6_facebook']}, 10:58:58 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:58:58 INFO - 'talos_options': ['--xperf_path', 10:58:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:58:58 INFO - 'tests': ['tp5n']}, 10:58:58 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 10:58:58 INFO - 'talos_options': ['--disable-stylo', 10:58:58 INFO - '--xperf_path', 10:58:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:58:58 INFO - 'tests': ['tp5n']}}} 10:58:58 INFO - Running post-action listener: _resource_record_post_action 10:58:58 INFO - [mozharness: 2017-09-07 17:58:58.562247Z] Finished populate-webroot step (success) 10:58:58 INFO - [mozharness: 2017-09-07 17:58:58.562336Z] Running create-virtualenv step. 10:58:58 INFO - Running pre-action listener: _resource_record_pre_action 10:58:58 INFO - Running main action method: create_virtualenv 10:58:58 INFO - Creating virtualenv /builds/slave/test/build/venv 10:58:58 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:58:58 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 10:58:58 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 10:58:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:58:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:58:59 INFO - Installing distribute.............................................................................................................................................................................................done. 10:58:59 INFO - Installing pip...............done. 10:58:59 INFO - Return code: 0 10:58:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:58:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:58:59 INFO - Reading from file tmpfile_stdout 10:58:59 INFO - Output received: 10:58:59 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 10:58:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:58:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:58:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:58:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:58:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:58:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x165c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1825a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c8a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19cc090>, '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 0x19ccd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c6f90>, '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': '923d835db2ba3686ebe126b700000192-1504807105.814051-1321574702', '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 10:58:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:58:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:58:59 INFO - Using env: {'DISPLAY': ':0', 10:58:59 INFO - 'HOME': '/home/cltbld', 10:58:59 INFO - 'LANG': 'en_US.UTF-8', 10:58:59 INFO - 'LANGUAGE': 'en_US:en', 10:58:59 INFO - 'LOGNAME': 'cltbld', 10:58:59 INFO - 'MAIL': '/var/mail/cltbld', 10:58:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:58:59 INFO - 'MOZ_NO_REMOTE': '1', 10:58:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:58:59 INFO - 'NO_EM_RESTART': '1', 10:58:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:58:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:58:59 INFO - 'PWD': '/builds/slave/test', 10:58:59 INFO - 'SHELL': '/bin/bash', 10:58:59 INFO - 'SHLVL': '1', 10:58:59 INFO - 'TERM': 'linux', 10:58:59 INFO - 'TMOUT': '86400', 10:58:59 INFO - 'USER': 'cltbld', 10:58:59 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1504807105.814051-1321574702', 10:58:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:58:59 INFO - '_': '/tools/buildbot/bin/python'} 10:59:00 INFO - Ignoring indexes: http://pypi.python.org/simple/ 10:59:00 INFO - Downloading/unpacking pip>=1.5 10:59:00 INFO - Running setup.py egg_info for package pip 10:59:00 INFO - warning: no files found matching 'pip/cacert.pem' 10:59:00 INFO - warning: no files found matching '*.html' under directory 'docs' 10:59:00 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 10:59:00 INFO - no previously-included directories found matching 'docs/_build/_sources' 10:59:00 INFO - Installing collected packages: pip 10:59:00 INFO - Found existing installation: pip 1.1 10:59:00 INFO - Uninstalling pip: 10:59:00 INFO - Successfully uninstalled pip 10:59:00 INFO - Running setup.py install for pip 10:59:00 INFO - warning: no files found matching 'pip/cacert.pem' 10:59:00 INFO - warning: no files found matching '*.html' under directory 'docs' 10:59:00 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 10:59:00 INFO - no previously-included directories found matching 'docs/_build/_sources' 10:59:00 INFO - Installing pip script to /builds/slave/test/build/venv/bin 10:59:00 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 10:59:00 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 10:59:00 INFO - Successfully installed pip 10:59:00 INFO - Cleaning up... 10:59:00 INFO - Return code: 0 10:59:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:59:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x165c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1825a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c8a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19cc090>, '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 0x19ccd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c6f90>, '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': '923d835db2ba3686ebe126b700000192-1504807105.814051-1321574702', '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 10:59:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:59:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:59:00 INFO - Using env: {'DISPLAY': ':0', 10:59:00 INFO - 'HOME': '/home/cltbld', 10:59:00 INFO - 'LANG': 'en_US.UTF-8', 10:59:00 INFO - 'LANGUAGE': 'en_US:en', 10:59:00 INFO - 'LOGNAME': 'cltbld', 10:59:00 INFO - 'MAIL': '/var/mail/cltbld', 10:59:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:00 INFO - 'MOZ_NO_REMOTE': '1', 10:59:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:59:00 INFO - 'NO_EM_RESTART': '1', 10:59:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:59:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:00 INFO - 'PWD': '/builds/slave/test', 10:59:00 INFO - 'SHELL': '/bin/bash', 10:59:00 INFO - 'SHLVL': '1', 10:59:00 INFO - 'TERM': 'linux', 10:59:00 INFO - 'TMOUT': '86400', 10:59:00 INFO - 'USER': 'cltbld', 10:59:00 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1504807105.814051-1321574702', 10:59:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:00 INFO - '_': '/tools/buildbot/bin/python'} 10:59:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:00 INFO - Downloading/unpacking psutil>=3.1.1 10:59:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:59:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:59:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:59:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:59:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:59:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:59:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:59:02 INFO - Installing collected packages: psutil 10:59:02 INFO - Running setup.py install for psutil 10:59:02 INFO - building 'psutil._psutil_linux' extension 10:59:02 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 10:59:02 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 10:59:02 INFO - building 'psutil._psutil_posix' extension 10:59:02 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 10:59:02 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 10:59:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:59:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:59:02 INFO - Successfully installed psutil 10:59:02 INFO - Cleaning up... 10:59:02 INFO - Return code: 0 10:59:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:59:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x165c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1825a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c8a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19cc090>, '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 0x19ccd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c6f90>, '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': '923d835db2ba3686ebe126b700000192-1504807105.814051-1321574702', '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 10:59:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:59:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:59:02 INFO - Using env: {'DISPLAY': ':0', 10:59:02 INFO - 'HOME': '/home/cltbld', 10:59:02 INFO - 'LANG': 'en_US.UTF-8', 10:59:02 INFO - 'LANGUAGE': 'en_US:en', 10:59:02 INFO - 'LOGNAME': 'cltbld', 10:59:02 INFO - 'MAIL': '/var/mail/cltbld', 10:59:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:02 INFO - 'MOZ_NO_REMOTE': '1', 10:59:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:59:02 INFO - 'NO_EM_RESTART': '1', 10:59:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:59:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:02 INFO - 'PWD': '/builds/slave/test', 10:59:02 INFO - 'SHELL': '/bin/bash', 10:59:02 INFO - 'SHLVL': '1', 10:59:02 INFO - 'TERM': 'linux', 10:59:02 INFO - 'TMOUT': '86400', 10:59:02 INFO - 'USER': 'cltbld', 10:59:02 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1504807105.814051-1321574702', 10:59:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:02 INFO - '_': '/tools/buildbot/bin/python'} 10:59:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:59:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:59:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:59:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:59:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:59:04 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:59:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:59:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:59:04 INFO - Installing collected packages: mozsystemmonitor 10:59:04 INFO - Running setup.py install for mozsystemmonitor 10:59:04 INFO - Successfully installed mozsystemmonitor 10:59:04 INFO - Cleaning up... 10:59:04 INFO - Return code: 0 10:59:04 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:59:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:04 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 0x165c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1825a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c8a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19cc090>, '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 0x19ccd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c6f90>, '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': '923d835db2ba3686ebe126b700000192-1504807105.814051-1321574702', '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 10:59:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:59:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:59:04 INFO - Using env: {'DISPLAY': ':0', 10:59:04 INFO - 'HOME': '/home/cltbld', 10:59:04 INFO - 'LANG': 'en_US.UTF-8', 10:59:04 INFO - 'LANGUAGE': 'en_US:en', 10:59:04 INFO - 'LOGNAME': 'cltbld', 10:59:04 INFO - 'MAIL': '/var/mail/cltbld', 10:59:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:04 INFO - 'MOZ_NO_REMOTE': '1', 10:59:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:59:04 INFO - 'NO_EM_RESTART': '1', 10:59:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:59:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:04 INFO - 'PWD': '/builds/slave/test', 10:59:04 INFO - 'SHELL': '/bin/bash', 10:59:04 INFO - 'SHLVL': '1', 10:59:04 INFO - 'TERM': 'linux', 10:59:04 INFO - 'TMOUT': '86400', 10:59:04 INFO - 'USER': 'cltbld', 10:59:04 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1504807105.814051-1321574702', 10:59:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:04 INFO - '_': '/tools/buildbot/bin/python'} 10:59:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:04 INFO - Downloading/unpacking jsonschema==2.5.1 10:59:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:59:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:59:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:59:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:59:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:59:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:59:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:59:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:59:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:59:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:59:05 INFO - Downloading functools32-3.2.3-2.tar.gz 10:59:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:59:05 INFO - warning: no files found matching '*.txt' 10:59:05 INFO - no previously-included directories found matching 'build' 10:59:05 INFO - no previously-included directories found matching 'dist' 10:59:05 INFO - no previously-included directories found matching '.git*' 10:59:05 INFO - Installing collected packages: jsonschema, functools32 10:59:05 INFO - Running setup.py install for functools32 10:59:05 INFO - warning: no files found matching '*.txt' 10:59:05 INFO - no previously-included directories found matching 'build' 10:59:05 INFO - no previously-included directories found matching 'dist' 10:59:05 INFO - no previously-included directories found matching '.git*' 10:59:05 INFO - Successfully installed jsonschema functools32 10:59:05 INFO - Cleaning up... 10:59:05 INFO - Return code: 0 10:59:05 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:59:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x165c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1825a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c8a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19cc090>, '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 0x19ccd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c6f90>, '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': '923d835db2ba3686ebe126b700000192-1504807105.814051-1321574702', '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 10:59:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:59:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 10:59:06 INFO - Using env: {'DISPLAY': ':0', 10:59:06 INFO - 'HOME': '/home/cltbld', 10:59:06 INFO - 'LANG': 'en_US.UTF-8', 10:59:06 INFO - 'LANGUAGE': 'en_US:en', 10:59:06 INFO - 'LOGNAME': 'cltbld', 10:59:06 INFO - 'MAIL': '/var/mail/cltbld', 10:59:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:06 INFO - 'MOZ_NO_REMOTE': '1', 10:59:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:59:06 INFO - 'NO_EM_RESTART': '1', 10:59:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:59:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:06 INFO - 'PWD': '/builds/slave/test', 10:59:06 INFO - 'SHELL': '/bin/bash', 10:59:06 INFO - 'SHLVL': '1', 10:59:06 INFO - 'TERM': 'linux', 10:59:06 INFO - 'TMOUT': '86400', 10:59:06 INFO - 'USER': 'cltbld', 10:59:06 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1504807105.814051-1321574702', 10:59:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:06 INFO - '_': '/tools/buildbot/bin/python'} 10:59:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:06 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:59:06 INFO - Cleaning up... 10:59:06 INFO - Return code: 0 10:59:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:59:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x165c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1825a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c8a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19cc090>, '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 0x19ccd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c6f90>, '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': '923d835db2ba3686ebe126b700000192-1504807105.814051-1321574702', '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 10:59:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:59:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:59:06 INFO - Using env: {'DISPLAY': ':0', 10:59:06 INFO - 'HOME': '/home/cltbld', 10:59:06 INFO - 'LANG': 'en_US.UTF-8', 10:59:06 INFO - 'LANGUAGE': 'en_US:en', 10:59:06 INFO - 'LOGNAME': 'cltbld', 10:59:06 INFO - 'MAIL': '/var/mail/cltbld', 10:59:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:06 INFO - 'MOZ_NO_REMOTE': '1', 10:59:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:59:06 INFO - 'NO_EM_RESTART': '1', 10:59:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:59:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:06 INFO - 'PWD': '/builds/slave/test', 10:59:06 INFO - 'SHELL': '/bin/bash', 10:59:06 INFO - 'SHLVL': '1', 10:59:06 INFO - 'TERM': 'linux', 10:59:06 INFO - 'TMOUT': '86400', 10:59:06 INFO - 'USER': 'cltbld', 10:59:06 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1504807105.814051-1321574702', 10:59:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:06 INFO - '_': '/tools/buildbot/bin/python'} 10:59:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:06 INFO - Downloading/unpacking blobuploader==1.2.4 10:59:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:59:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:59:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:59:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:59:07 INFO - Downloading blobuploader-1.2.4.tar.gz 10:59:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:59:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:59:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:59:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:59:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:59:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:59:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:59:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:59:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:59:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:59:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:59:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:59:08 INFO - Downloading docopt-0.6.1.tar.gz 10:59:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:59:08 INFO - Installing collected packages: blobuploader, requests, docopt 10:59:08 INFO - Running setup.py install for blobuploader 10:59:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:59:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:59:08 INFO - Running setup.py install for requests 10:59:08 INFO - Running setup.py install for docopt 10:59:08 INFO - Successfully installed blobuploader requests docopt 10:59:08 INFO - Cleaning up... 10:59:08 INFO - Return code: 0 10:59:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:59:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:08 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 0x165c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1825a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c8a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19cc090>, '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 0x19ccd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c6f90>, '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': '923d835db2ba3686ebe126b700000192-1504807105.814051-1321574702', '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 10:59:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:59:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:59:08 INFO - Using env: {'DISPLAY': ':0', 10:59:08 INFO - 'HOME': '/home/cltbld', 10:59:08 INFO - 'LANG': 'en_US.UTF-8', 10:59:08 INFO - 'LANGUAGE': 'en_US:en', 10:59:08 INFO - 'LOGNAME': 'cltbld', 10:59:08 INFO - 'MAIL': '/var/mail/cltbld', 10:59:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:08 INFO - 'MOZ_NO_REMOTE': '1', 10:59:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:59:08 INFO - 'NO_EM_RESTART': '1', 10:59:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:59:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:08 INFO - 'PWD': '/builds/slave/test', 10:59:08 INFO - 'SHELL': '/bin/bash', 10:59:08 INFO - 'SHLVL': '1', 10:59:08 INFO - 'TERM': 'linux', 10:59:08 INFO - 'TMOUT': '86400', 10:59:08 INFO - 'USER': 'cltbld', 10:59:08 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1504807105.814051-1321574702', 10:59:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:08 INFO - '_': '/tools/buildbot/bin/python'} 10:59:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:59:08 INFO - Running setup.py (path:/tmp/pip-MbhzjW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:59:08 INFO - Running setup.py (path:/tmp/pip-pP_qNt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:59:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:59:09 INFO - Running setup.py (path:/tmp/pip-D7YcKq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:59:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:59:09 INFO - Running setup.py (path:/tmp/pip-teXAKl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:59:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:59:09 INFO - Running setup.py (path:/tmp/pip-OdsBsr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:59:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:59:09 INFO - Running setup.py (path:/tmp/pip-RoSAgt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:59:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:59:09 INFO - Running setup.py (path:/tmp/pip-e0lFbw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:59:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:59:09 INFO - Running setup.py (path:/tmp/pip-NMAI6o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:59:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:59:09 INFO - Running setup.py (path:/tmp/pip-XqEJvs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:59:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:59:09 INFO - Running setup.py (path:/tmp/pip-mSUqcP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:59:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:59:09 INFO - Running setup.py (path:/tmp/pip-n7QbnJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:59:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:59:09 INFO - Running setup.py (path:/tmp/pip-72oZyv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:59:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:59:09 INFO - Running setup.py (path:/tmp/pip-kpDWeF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:59:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:59:09 INFO - Running setup.py (path:/tmp/pip-3tXmWz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:59:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:59:09 INFO - Running setup.py (path:/tmp/pip-CXgNn_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:59:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:59:09 INFO - Running setup.py (path:/tmp/pip-3qqOND-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:59:10 INFO - Running setup.py (path:/tmp/pip-mHp9LF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:59:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:59:10 INFO - Running setup.py install for manifestparser 10:59:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:59:10 INFO - Running setup.py install for mozcrash 10:59:10 INFO - Running setup.py install for mozdebug 10:59:10 INFO - Running setup.py install for mozdevice 10:59:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:59:10 INFO - Running setup.py install for mozfile 10:59:10 INFO - Running setup.py install for mozhttpd 10:59:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:59:10 INFO - Running setup.py install for mozinfo 10:59:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:59:10 INFO - Running setup.py install for mozInstall 10:59:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:59:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:59:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:59:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:59:10 INFO - Running setup.py install for mozleak 10:59:10 INFO - Running setup.py install for mozlog 10:59:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:59:11 INFO - Running setup.py install for moznetwork 10:59:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:59:11 INFO - Running setup.py install for mozprocess 10:59:11 INFO - Running setup.py install for mozprofile 10:59:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:59:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:59:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:59:11 INFO - Running setup.py install for mozrunner 10:59:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:59:11 INFO - Running setup.py install for mozscreenshot 10:59:11 INFO - Running setup.py install for moztest 10:59:11 INFO - Running setup.py install for mozversion 10:59:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:59:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:59:11 INFO - Cleaning up... 10:59:11 INFO - Return code: 0 10:59:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:59:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:11 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 0x165c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1825a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c8a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19cc090>, '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 0x19ccd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c6f90>, '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': '923d835db2ba3686ebe126b700000192-1504807105.814051-1321574702', '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 10:59:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:59:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:59:11 INFO - Using env: {'DISPLAY': ':0', 10:59:11 INFO - 'HOME': '/home/cltbld', 10:59:11 INFO - 'LANG': 'en_US.UTF-8', 10:59:11 INFO - 'LANGUAGE': 'en_US:en', 10:59:11 INFO - 'LOGNAME': 'cltbld', 10:59:11 INFO - 'MAIL': '/var/mail/cltbld', 10:59:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:11 INFO - 'MOZ_NO_REMOTE': '1', 10:59:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:59:11 INFO - 'NO_EM_RESTART': '1', 10:59:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:59:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:11 INFO - 'PWD': '/builds/slave/test', 10:59:11 INFO - 'SHELL': '/bin/bash', 10:59:11 INFO - 'SHLVL': '1', 10:59:11 INFO - 'TERM': 'linux', 10:59:11 INFO - 'TMOUT': '86400', 10:59:11 INFO - 'USER': 'cltbld', 10:59:11 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1504807105.814051-1321574702', 10:59:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:11 INFO - '_': '/tools/buildbot/bin/python'} 10:59:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:59:12 INFO - Running setup.py (path:/tmp/pip-HTEIYp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:59:12 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:59:12 INFO - Running setup.py (path:/tmp/pip-7Anvoa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:59:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:59:12 INFO - Running setup.py (path:/tmp/pip-_JQdYg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:59:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:59:12 INFO - Running setup.py (path:/tmp/pip-gDvdVu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:59:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:59:12 INFO - Running setup.py (path:/tmp/pip-bl10hQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:59:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:59:12 INFO - Running setup.py (path:/tmp/pip-UPTGFz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:59:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:59:12 INFO - Running setup.py (path:/tmp/pip-klRTG2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:59:12 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)) 10:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:59:12 INFO - Running setup.py (path:/tmp/pip-z35nY1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:59:12 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)) 10:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:59:12 INFO - Running setup.py (path:/tmp/pip-ddWmuE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:59:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:59:12 INFO - Running setup.py (path:/tmp/pip-vXeUaN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:59:12 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)) 10:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:59:12 INFO - Running setup.py (path:/tmp/pip-hF_6dq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:59:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:59:12 INFO - Running setup.py (path:/tmp/pip-wyJUlS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:59:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:59:12 INFO - Running setup.py (path:/tmp/pip-UrVp_z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:59:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:59:13 INFO - Running setup.py (path:/tmp/pip-_M_1KW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:59:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:59:13 INFO - Running setup.py (path:/tmp/pip-YLgxeK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:59:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:59:13 INFO - Running setup.py (path:/tmp/pip-obehdj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:59:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:59:13 INFO - Running setup.py (path:/tmp/pip-HPDVKI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:59:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:59:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:59:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:59:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:59:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:59:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:59:13 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)) 10:59:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:59:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:59:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:59:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:59:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:59:14 INFO - Downloading blessings-1.6.tar.gz 10:59:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:59:14 INFO - Installing collected packages: blessings 10:59:14 INFO - Running setup.py install for blessings 10:59:14 INFO - Successfully installed blessings 10:59:14 INFO - Cleaning up... 10:59:14 INFO - Return code: 0 10:59:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:59:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:59:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:59:14 INFO - Reading from file tmpfile_stdout 10:59:14 INFO - Current package versions: 10:59:14 INFO - argparse == 1.2.1 10:59:14 INFO - blessings == 1.6 10:59:14 INFO - blobuploader == 1.2.4 10:59:14 INFO - docopt == 0.6.1 10:59:14 INFO - functools32 == 3.2.3-2 10:59:14 INFO - jsonschema == 2.5.1 10:59:14 INFO - manifestparser == 1.1 10:59:14 INFO - mozInstall == 1.13 10:59:14 INFO - mozcrash == 1.0 10:59:14 INFO - mozdebug == 0.1 10:59:14 INFO - mozdevice == 0.51 10:59:14 INFO - mozfile == 1.2 10:59:14 INFO - mozhttpd == 0.7 10:59:14 INFO - mozinfo == 0.10 10:59:14 INFO - mozleak == 0.1 10:59:14 INFO - mozlog == 3.5 10:59:14 INFO - moznetwork == 0.27 10:59:14 INFO - mozprocess == 0.25 10:59:14 INFO - mozprofile == 0.28 10:59:14 INFO - mozrunner == 6.13 10:59:14 INFO - mozscreenshot == 0.1 10:59:14 INFO - mozsystemmonitor == 0.3 10:59:14 INFO - moztest == 0.8 10:59:14 INFO - mozversion == 1.4 10:59:14 INFO - psutil == 3.1.1 10:59:14 INFO - requests == 1.2.3 10:59:14 INFO - wsgiref == 0.1.2 10:59:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:59:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:14 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 0x165c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1825a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c8a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19cc090>, '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 0x19ccd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c6f90>, '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': '923d835db2ba3686ebe126b700000192-1504807105.814051-1321574702', '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 10:59:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:59:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:59:14 INFO - Using env: {'DISPLAY': ':0', 10:59:14 INFO - 'HOME': '/home/cltbld', 10:59:14 INFO - 'LANG': 'en_US.UTF-8', 10:59:14 INFO - 'LANGUAGE': 'en_US:en', 10:59:14 INFO - 'LOGNAME': 'cltbld', 10:59:14 INFO - 'MAIL': '/var/mail/cltbld', 10:59:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:14 INFO - 'MOZ_NO_REMOTE': '1', 10:59:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:59:14 INFO - 'NO_EM_RESTART': '1', 10:59:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:59:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:14 INFO - 'PWD': '/builds/slave/test', 10:59:14 INFO - 'SHELL': '/bin/bash', 10:59:14 INFO - 'SHLVL': '1', 10:59:14 INFO - 'TERM': 'linux', 10:59:14 INFO - 'TMOUT': '86400', 10:59:14 INFO - 'USER': 'cltbld', 10:59:14 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1504807105.814051-1321574702', 10:59:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:14 INFO - '_': '/tools/buildbot/bin/python'} 10:59:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:59:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:59:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:59:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:59:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:59:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:59:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:59:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:59:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:59:15 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 10:59:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:59:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:59:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:59:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:59:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 10:59:16 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:59:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:59:16 INFO - Installing collected packages: simplejson 10:59:16 INFO - Running setup.py install for simplejson 10:59:16 INFO - building 'simplejson._speedups' extension 10:59:16 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 10:59:17 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 10:59:17 INFO - Successfully installed simplejson 10:59:17 INFO - Cleaning up... 10:59:17 INFO - Return code: 0 10:59:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:59:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:17 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 0x165c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1825a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c8a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19cc090>, '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 0x19ccd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c6f90>, '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': '923d835db2ba3686ebe126b700000192-1504807105.814051-1321574702', '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 10:59:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:59:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:59:17 INFO - Using env: {'DISPLAY': ':0', 10:59:17 INFO - 'HOME': '/home/cltbld', 10:59:17 INFO - 'LANG': 'en_US.UTF-8', 10:59:17 INFO - 'LANGUAGE': 'en_US:en', 10:59:17 INFO - 'LOGNAME': 'cltbld', 10:59:17 INFO - 'MAIL': '/var/mail/cltbld', 10:59:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:17 INFO - 'MOZ_NO_REMOTE': '1', 10:59:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:59:17 INFO - 'NO_EM_RESTART': '1', 10:59:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:59:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:17 INFO - 'PWD': '/builds/slave/test', 10:59:17 INFO - 'SHELL': '/bin/bash', 10:59:17 INFO - 'SHLVL': '1', 10:59:17 INFO - 'TERM': 'linux', 10:59:17 INFO - 'TMOUT': '86400', 10:59:17 INFO - 'USER': 'cltbld', 10:59:17 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1504807105.814051-1321574702', 10:59:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:17 INFO - '_': '/tools/buildbot/bin/python'} 10:59:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:17 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:59:17 INFO - Cleaning up... 10:59:17 INFO - Return code: 0 10:59:17 INFO - Running post-action listener: _resource_record_post_action 10:59:17 INFO - Running post-action listener: _start_resource_monitoring 10:59:17 INFO - Starting resource monitoring. 10:59:17 INFO - [mozharness: 2017-09-07 17:59:17.606356Z] Finished create-virtualenv step (success) 10:59:17 INFO - [mozharness: 2017-09-07 17:59:17.606873Z] Running install step. 10:59:17 INFO - Running pre-action listener: _resource_record_pre_action 10:59:17 INFO - Running main action method: install 10:59:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:59:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:59:17 INFO - Reading from file tmpfile_stdout 10:59:17 INFO - Detecting whether we're running mozinstall >=1.0... 10:59:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:59:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:59:17 INFO - Reading from file tmpfile_stdout 10:59:17 INFO - Output received: 10:59:17 INFO - Usage: mozinstall [options] installer 10:59:17 INFO - Options: 10:59:17 INFO - -h, --help show this help message and exit 10:59:17 INFO - -d DEST, --destination=DEST 10:59:17 INFO - Directory to install application into. [default: 10:59:17 INFO - "/builds/slave/test"] 10:59:17 INFO - --app=APP Application being installed. [default: firefox] 10:59:17 INFO - mkdir: /builds/slave/test/build/application 10:59:17 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'] 10:59:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 10:59:34 INFO - Reading from file tmpfile_stdout 10:59:34 INFO - Output received: 10:59:34 INFO - /builds/slave/test/build/application/firefox/firefox 10:59:34 INFO - Running post-action listener: _resource_record_post_action 10:59:34 INFO - [mozharness: 2017-09-07 17:59:34.535395Z] Finished install step (success) 10:59:34 INFO - [mozharness: 2017-09-07 17:59:34.535645Z] Running setup-mitmproxy step. 10:59:34 INFO - Running pre-action listener: _resource_record_pre_action 10:59:34 INFO - Running main action method: setup_mitmproxy 10:59:34 INFO - Skipping: mitmproxy is not required 10:59:34 INFO - Running post-action listener: _resource_record_post_action 10:59:34 INFO - [mozharness: 2017-09-07 17:59:34.536778Z] Finished setup-mitmproxy step (success) 10:59:34 INFO - [mozharness: 2017-09-07 17:59:34.536995Z] Running run-tests step. 10:59:34 INFO - Running pre-action listener: _resource_record_pre_action 10:59:34 INFO - Running pre-action listener: _set_gcov_prefix 10:59:34 INFO - Running main action method: run_tests 10:59:34 WARNING - Try message not found. 10:59:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:59:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:59:34 INFO - Python 2.7.3 10:59:34 INFO - Return code: 0 10:59:34 INFO - grabbing minidump binary from tooltool 10:59: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')]} 10:59:34 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 0x19cc090>, '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 0x19ccd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c6f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:59:34 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 10:59:34 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 10:59:34 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 10:59:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:59:34 INFO - Return code: 0 10:59:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:59:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:59:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:59:34 INFO - ENV: RUST_BACKTRACE is now full 10:59:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:59:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:59:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 10:59:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-007 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 10:59:34 INFO - Using env: {'DISPLAY': ':0', 10:59:34 INFO - 'HOME': '/home/cltbld', 10:59:34 INFO - 'LANG': 'en_US.UTF-8', 10:59:34 INFO - 'LANGUAGE': 'en_US:en', 10:59:34 INFO - 'LOGNAME': 'cltbld', 10:59:34 INFO - 'MAIL': '/var/mail/cltbld', 10:59:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:59:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:59:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:34 INFO - 'MOZ_NO_REMOTE': '1', 10:59:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:59:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:59:34 INFO - 'NO_EM_RESTART': '1', 10:59:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:59:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:34 INFO - 'PWD': '/builds/slave/test', 10:59:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:59:34 INFO - 'RUST_BACKTRACE': 'full', 10:59:34 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 10:59:34 INFO - 'SHELL': '/bin/bash', 10:59:34 INFO - 'SHLVL': '1', 10:59:34 INFO - 'STYLO_FORCE_ENABLED': '1', 10:59:34 INFO - 'STYLO_THREADS': '1', 10:59:34 INFO - 'TERM': 'linux', 10:59:34 INFO - 'TMOUT': '86400', 10:59:34 INFO - 'USER': 'cltbld', 10:59:34 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1504807105.814051-1321574702', 10:59:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:34 INFO - '_': '/tools/buildbot/bin/python'} 10:59:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 10:59:34 INFO - mozversion application_buildid: 20170907171306 10:59:34 INFO - mozversion application_changeset: 3c96d611ebd67fc219d22bcb476a72412c76f6c7 10:59:34 INFO - mozversion application_display_name: Nightly 10:59:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:59:34 INFO - mozversion application_name: Firefox 10:59:34 INFO - mozversion application_remotingname: firefox 10:59:34 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:59:34 INFO - mozversion application_vendor: Mozilla 10:59:34 INFO - mozversion application_version: 57.0a1 10:59:34 INFO - mozversion platform_buildid: 20170907171306 10:59:34 INFO - mozversion platform_changeset: 3c96d611ebd67fc219d22bcb476a72412c76f6c7 10:59:34 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:59:34 INFO - mozversion platform_version: 57.0a1 10:59:34 INFO - using testdate: 1504807174 10:59:34 INFO - actual date: 1504807174 10:59:34 INFO - starting webserver on 'localhost:52330' 10:59:34 INFO - SUITE-START | Running 2 tests 10:59:34 INFO - TEST-START | dromaeo_css 10:59:34 INFO - Initialising browser for dromaeo_css test... 10:59:34 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:52330/getInfo.html -profile /tmp/tmpufoWjd/profile 10:59:34 INFO - TEST-INFO | started process 18104 (/builds/slave/test/build/application/firefox/firefox http://localhost:52330/getInfo.html) 10:59:39 INFO - TEST-INFO | 18104: exit 0 10:59:39 INFO - Browser initialized. 10:59:39 INFO - Running cycle 1/1 for dromaeo_css test... 10:59:39 INFO - Using env: {'DISPLAY': ':0', 10:59:39 INFO - 'HOME': '/home/cltbld', 10:59:39 INFO - 'JSGC_DISABLE_POISONING': '1', 10:59:39 INFO - 'LANG': 'en_US.UTF-8', 10:59:39 INFO - 'LANGUAGE': 'en_US:en', 10:59:39 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 10:59:39 INFO - 'LOGNAME': 'cltbld', 10:59:39 INFO - 'MAIL': '/var/mail/cltbld', 10:59:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:59:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:59:39 INFO - 'MOZ_CRASHREPORTER': '1', 10:59:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:39 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 10:59:39 INFO - 'MOZ_NO_REMOTE': '1', 10:59:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:59:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:59:39 INFO - 'NO_EM_RESTART': '1', 10:59:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:59:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:39 INFO - 'PWD': '/builds/slave/test', 10:59:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:59:39 INFO - 'RUST_BACKTRACE': 'full', 10:59:39 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 10:59:39 INFO - 'SHELL': '/bin/bash', 10:59:39 INFO - 'SHLVL': '1', 10:59:39 INFO - 'STYLO_FORCE_ENABLED': '1', 10:59:39 INFO - 'STYLO_THREADS': '1', 10:59:39 INFO - 'TERM': 'linux', 10:59:39 INFO - 'TMOUT': '86400', 10:59:39 INFO - 'USER': 'cltbld', 10:59:39 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1504807105.814051-1321574702', 10:59:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:39 INFO - '_': '/tools/buildbot/bin/python'} 10:59:39 INFO - TEST-INFO | started process 18290 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpufoWjd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 10:59:40 INFO - PID 18290 | 10:59:40 INFO - PID 18290 | (/builds/slave/test/build/application/firefox/firefox:18341): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 10:59:40 INFO - PID 18290 | 10:59:51 INFO - PID 18290 | RSS: Main: 172249088 10:59:51 INFO - PID 18290 | 11:02:48 INFO - PID 18290 | Cycle 1(1): loaded http://localhost:52330/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52330/tests/dromaeo/cssquery-ext.html) 11:02:50 INFO - PID 18290 | RSS: Main: 174346240 11:02:50 INFO - PID 18290 | 11:05:51 INFO - PID 18290 | Cycle 1(1): loaded http://localhost:52330/tests/dromaeo/cssquery-ext.html (next: http://localhost:52330/tests/dromaeo/cssquery-jquery.html) 11:05:52 INFO - PID 18290 | RSS: Main: 170532864 11:05:52 INFO - PID 18290 | 11:08:54 INFO - PID 18290 | Cycle 1(1): loaded http://localhost:52330/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52330/tests/dromaeo/cssquery-mootools.html) 11:08:54 INFO - PID 18290 | RSS: Main: 173039616 11:08:54 INFO - PID 18290 | 11:11:56 INFO - PID 18290 | Cycle 1(1): loaded http://localhost:52330/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52330/tests/dromaeo/cssquery-prototype.html) 11:11:57 INFO - PID 18290 | RSS: Main: 171737088 11:11:57 INFO - PID 18290 | 11:15:00 INFO - PID 18290 | Cycle 1(1): loaded http://localhost:52330/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52330/tests/dromaeo/cssquery-yui.html) 11:15:01 INFO - PID 18290 | RSS: Main: 172826624 11:15:01 INFO - PID 18290 | 11:18:02 INFO - PID 18290 | Cycle 1(1): loaded http://localhost:52330/tests/dromaeo/cssquery-yui.html (next: http://localhost:52330/tests/dromaeo/cssquery-dojo.html) 11:18:03 INFO - PID 18290 | RSS: Main: 173932544 11:18:03 INFO - PID 18290 | 11:18:03 INFO - PID 18290 | __start_tp_report 11:18:03 INFO - PID 18290 | _x_x_mozilla_page_load 11:18:03 INFO - PID 18290 | _x_x_mozilla_page_load_details 11:18:03 INFO - PID 18290 | |i|pagename|runs| 11:18:03 INFO - PID 18290 | |0;dojo.html;3221.420144374013;3252;3258.2831777009064;3258.6741325867415;3284.0312107928157;6286.3713628637115;6479.578827376217;6514.80455586332;6519.641419721914;6541;6342.936570634292;6435.227772667275;6435.452986496141;6442.742290308393;6451.225852897647;5854.707264636772;5877.0009098453365;5906.084556893688;5915.053591425372;5950.04799232123;5929.584929054968;5933.317668468117;5936.5250779937505;5945;5956.612820166697;6015.428534289235;6026.789062382817;6039.758409663608;6044.788432404866;6050.638606313566;5958.523318134538;6013.669248191348;6028.336882942873;6049.243844519435;6069.999999999955;5740.311162660466;5796.942030579725;5924.496417804492;5933.4659880610525;5992.34084250732;6289.308176100625;6318.526110541728;6452.7418903243815;6455.031745238205;6518.543701940866;6912.4815638826785;6913.792586222421;6990.440764738809;7015.4036906862975;7025.402840758542;6775.22084960226;6834.1457317835275;6883.139607549057;6894.517383783137;6941.201761797407;6298.7480500780375;6318.241810982711;6327.46216571592;6330.145430366888;6339.175907132043;6967.268436814163;6976.372126508537;6986.091808065021;7077.469189810785;7131.857362852714;6756.662166891636;6846.144231971004;6865.244823069458;6871.03805467235;6890.621015844176;6941.826454338682;7008.929910700827;7023.824404389931;7033.577985320897;7039;6876.449884009267;6887.827804304932;6901.516893817385;6974.476914231453;6984.406325462291;6696.46428285736;6761.628110453874;6874.621895795779;6962.373386395248;6991.965040174767;5451.236826844245;5477.780888764405;5480.506754392124;5482.5613950883835;5486.177073439016;4797.64017698674;4827.372441582642;4845.079434907357;4847.175980083394;4878.9512104878495;5796.304443466811;6019.729112189962;6027.969860150672;6089.117078023662;6105.206323178048;6821.829454263683;6853.828654283583;6855.07456493377;6867;6872.518923675295;5922.763089476372;5939.673317967553;5940.435658612425;5940.673262970492;5951.256092988377;5864.47219750216;5880.411958804086;5881.1178323251;5907.261592300963;6056.757729690763;6090.23872015998;6595.70319335631;6598.60408375499;6602.636854973022;6630.237522684856;6828.658567071726;6839;6858.142732158481;6861.039454476477;6863.519553631198;6595.967020164869;6602.8679426410245;6615.4376877965915;6619.7683081093855;6757.763478278237;6859;6884.105066341343;6958.512904096665;6961.756338528127;6974.651267436507;6794.150731158606;6994.300569942965;6998.825029374103;7085.504014719127;7097.751578694721;6585.934140658724;6603.867922641616;6617.007448882706;6617.536772426077;6621.801345959629;5708.514776244066;6564.868702625825;6612.933870661424;6614.437772789367;6832.863342733018;6672.065910772592;6680.5323627345615;6785.5250132490255;6785.93214067853;6789.830254243683;6615.305392933673;6689.397954184147;6730;6810.62541560219;6873.140857392826;6371.49028077762;6373.044043393343;6388.9041664374145;6500.869982600416;6600.372964568358 11:18:03 INFO - PID 18290 | |1;ext.html;848.7114381110423;860.6299291304745;870.4168207301108;870.4646642314979;879.9164079412456;39519;43150.56849431505;43583.564164358344;43831.12337753247;43841.12317753643;39603.80198099006;39886.800565997204;39955;40091.39862902059;40101.598984010154;6995.895061574068;7133.464990125735;7623.656935437919;7849;7894.60526973649;7679.232076792332;7794.844103117963;7795.493292935969;7796.454248202628;7807.297343239107;7794.337481314095;7832.921670783277;7869.48848324857;7874.5668988205625;7885.329746971514;7703.191164927686;7731.961340193319;7733.8066548336465;7780.027496562958;7813.96093019537;7614.8197029460525;7689.538627682357;7690;7699.6920123195005;7718.073831140299;37930.81034594837;38215.04462388463;38265.61734382648;38481;38646;3445.534852794866;3493.1441796759955;3495.0563347895927;3499.3526197653514;3500.8949731508096;30239;30365.24086897823;30419.69580304191;30554.69445305563;30826.691733082607;4864.708117512961;4993.775280112403;5044.798208071673;5082.771275292584;5106.412762532319;178772;178953;179178;180328;180451;40967;41998.37002444966;46640.30039549342;46933.29600056002;47203;50242;50951;50997.490025100014;50997.7450112747;51370.917744935425;15866.603334916488;16014.839851601335;16033.038017718975;16054.197290135446;16065;13250.933745331404;13261.469541218436;13288.468461261635;13290.800637990438;13296.867031329562;13670.658233544242;13772.449102036007;13790.586282411543;13848.446062157402;13954.651133721738;5477.397486276506;5553.805616803393;5587.608867379245;5596.944030559724;5792.536597072224;991.1129539062642;1010.9747256318503;1015.7968406318765;1019.1642852860583;1028.7788125553043;22823.88588057049;29351.412971740447;29702.257443564085;30191.396172076875;30507.69492305093;1101.4492753623188;1104.5416152296868;1105.4472763618191;1113.0983903038402;1114.9721256968642;12386.938065309616;12769.425375858109;12813.551525696555;12880.420381082873;13030.934845325713;251522;253770;255002;255106;255646;53528.73235633797;53658.19512707312;54026.72986635042;54151.45848541543;54312.45687543153;1404.8243969503812;1437.0515459796484;1459.073488334915;1459.2484870291808;1459.3578825316827;22806.429839254153;22943;22985.54028919379;23087.307380778602;23480.295591132293;37986;38124.809375952944;38214.80892595519;38261.617383825804;38337.42493862539;212518;213101;213533;213702;213992;34027.65972340245;36623.26753464969;38405.23189536249;38528;38547.80726096351;45858;46418.53581464142;46796;46821;46865.76567117142;33757.66242337545;33829.3234135311;34444.82777586096;34473.48289775706;34658.30683386369;33710.157246069044;33810.32379352448;33927.4910876342;33958;34788.130296742784;38845.44618215353;39177.80411097926;39275.607243927196;39417.21165576615;39543.604563953995;33362;33517.83241083779;33533.16167095842;33605.66394336123;34386;23603.527929441658;24328.635070474313;24648;24787.504249915262;25034.874825625757 11:18:03 INFO - PID 18290 | |2;jquery.html;540.2619031097277;564.7515093358925;570.3355590736792;578.1443463673761;588.370443625321;22211.333659990185;22838.314850554467;22856.31431057067;22914.312570622867;22935.770642293573;23429.64855527164;24233;24528.754712452872;24797.13210037649;25087.247382578505;6323.367663233675;6404.23149222094;6451.806445806634;6455.61266324022;6486.545941784077;6291.245050593935;6365.331640177784;6463;6466.515011374142;6474.805755827333;6504.70728817202;6525;6529.34706529348;6559.901601475982;6563.01554766784;6540.672966351711;6541.705623246965;6549.541532092755;6553.50848686348;6556.868862622769;5737.799177028825;5929.792457264019;5961.2846458425265;5978.521718262572;5978.581499295051;28213.717862821315;28554.714452855413;28637.28406789826;28672.85663571669;28675.71324286772;2008.4878356019267;2031.5530583271657;2034.6846238833004;2042.3158241988951;2045.079714128648;18921.432357029313;18923.62152756951;19346.516337091543;19476.80523194764;19533.218671253133;2359.504504054151;2401.3396316013063;2453.386653336666;2455.226603619854;2466.0505705303585;123192.38403808013;129205;137558;140414.29792851073;143844;14249.783132296561;14354.927326307336;14523.564293071226;14813.114655942481;14859.427714607022;22171.445713857283;22414.215502457337;22424;22486.212982545534;22489.662655060187;10240.846387304196;10265.178785697126;10277.897221027844;10355.534000969974;10400.427976461368;9787.706368808947;9805.509724513746;9815.460149691693;9847.556859941176;9880.209583233467;8836.690715824916;8877.279389039039;9087.409318394282;9138.13187747163;9222.492762897971;2632.2761240658588;2674.1576403432855;2747.2719729271757;2747.986260068687;2774.1677496750895;955.2310390136007;955.7766059443923;959.467495539968;969.185883857563;971.455984648599;18514.907425462785;18670.813291866907;18734.906325468284;18744.222072308476;19125.808741912402;1020.7295066807302;1028.927975041755;1032.7986042721598;1035.7255327338262;1036.9740756480996;10414.166866650801;10479.633212837667;10506.474676266156;10558.788824223473;10719.410432426292;465776;541175.8823617649;543735;544784;545627;119163;125000;125232.37383813022;125538;127243;1156.1329003247565;1201.5101274419483;1224.7244370016674;1239.3803098450774;1244.6266120163914;19828.405147845588;19915.701264480755;20210.494737631678;20306.69539956872;20311.898440507703;58943.115853263094;60749;60986;61195;61385.693071534355;74062;74375;74650.62674686592;74750;76351.2364876344;13725.382357793724;14108.858911410754;14111.788323174955;14112.223827689575;14113.2943352834;22022.779772202073;22383.104675812785;22388.21641242549;22484.550308993403;22554.548909022054;17525.824741752418;17764.46706598804;17835.286588536314;17887.552811179823;17903;15767.763483547527;16065.27706253198;16255.837441625905;16389.34442622282;16478.75281870749;18507.259709612004;18685.15916783775;18688.439346819618;18719.157637906053;18918.243270269584;13677.31613419345;14309.499167529086;14497.637559061108;14508.492202773274;14539.34572944199;18281.3601523946;18506.352277670216;18520.722189166903;18550.721739174194;18589.721154182967 11:18:03 INFO - PID 18290 | |3;mootools.html;1341.483528841396;1383.6748364134432;1383.6886700492387;1386.5978866128817;1389.7915312703094;14649.560513184608;15290.235488225586;15347.923260383683;15358.078515289077;15662.216889155554;15534.37862485502;15772.76340854888;15851.920740396281;15853.20733963303;15856.28646710898;2724.1827451764443;2793.5809628555676;2820.915372538817;2821.2241633550834;2872.5116730155924;2788.776897848167;2803.9719602804016;2814.9718502814912;2816.2818481287245;2818.3940452802644;2786.192004318755;2834.3622684895836;2835.517961946474;2835.7589604883506;2835.957460638092;2721.2788611018095;2734.343757498206;2735.8084934054623;2741.3420779013095;2744.533429317021;2684.704682484925;2706.986465067682;2707.0254708304997;2707.323169207698;2709.0924540278834;14847.70304593902;14967.176805275705;15192.088474691554;15307.693846123015;15319.31063102163;7773.7667869963425;8140.3487720982175;8142.063662678808;8142.145074767123;8142.51144931306;5379.5427388671615;5633.239512665778;5751.194832723422;5802.7388767505145;5806.506446952014;1895.3934740882924;1922.951926201842;1924.595834874678;1972.1815446589649;1989.1744925855753;26690.06584769543;26913.32716682079;26978.865105674544;27051.458970820473;27189.456210875673;6794.694238759268;6820.386165245052;6909.723611055602;6949.548279361826;7027.15674119109;17131.486055418358;17255.56861078458;17270.13649317529;17289.394871179447;17294.913525432294;7609.6575654095695;7709.653065612061;7715.267049630276;7716.228377162239;7721.305082542486;5906.8818623627285;6000.879982400327;6292.559520833589;6295;7468.775936721907;5246.344206974129;5379.838604841861;5380.085385484477;5469.511372325583;5609.5792815539;1559.0723519505875;1575.6060984753813;1575.8975666581864;1589.8887077904435;1609.7102521546;895.7939673875045;912.8950170730318;916.5417291354323;916.7983043730369;928.0580211085753;7586.772396828104;7691.961540192263;7721.459497835098;7792.298693117533;7817.960910195413;712.9857402851914;718.1238888555953;726.57132291948;729.9160596531467;740.4779630360583;4544.977275113603;4551.3173024046655;4714.127886340969;4990.426100998432;5195.376554813447;20647.690284645443;22283.777162228493;22489.32532024042;22490.100395983976;22491.66262506064;21289.722616643052;21496.785032149477;22005;22170.334889953327;22182.445438863833;11300.265482743594;11636.534538618529;11735.354555499358;11764.470598823074;11778.52885884555;8547.61535730906;8816.735497935073;8891.955540222258;9090.500022498825;9158.633654653739;18656.813431865507;19092.04539772978;19228.23087076501;19487.70768438503;19709.704354434984;19097.331593394163;19336.903315483334;19468;19543.511412214808;19849.503762406057;12112.515499380279;12258.938705306417;12379.381030948236;12388.070894683115;12388.938055309665;14153.292335383396;14223.217723025333;14257.00200985921;14261.572152835432;14263.42946282137;11377.54489820431;11420.885791141982;11428.542858285908;11520.193586449202;11752.764944700886;10953.890461095605;11204.719882003015;11347.829782553434;11481.311121332747;11499.08007359426;10378.273520853469;10589.4705264738;10601.098906593026;10602.46987650599;10607.363558186533;7249.347558719741;7269.636518174176;7282.635868206675;7300.525465844703;7304.086989126359;7485.5508669480005;7504.962475187589;7547.358474529727;7566.508176968479;7587.734429294948 11:18:03 INFO - PID 18290 | |4;prototype.html;507.59680351202115;520.2040877457491;521.1583292981834;531.5295963072682;533.194875737636;6472;6487.935120648792;6491.221053473578;6512.413882750551;6563.015547667852;6249.750009999594;6404.199475065617;6414.839629009277;6459.580127291722;6473.9930621507365;5288.788448462057;5289.8626795238915;5297.682139071649;5303.045451818671;5339.8252384475545;4907.723991762132;5208.531232189102;5233.581313494911;5259.684418934857;5336.866578335534;4925.3350797642215;5024.598032157419;5032.521910418523;5069.163588007993;5076.40093370589;5015.924761128549;5046.9747651261505;5103.5151660592555;5113.974430127862;5121.795128194868;4515.954840451586;4533.750643714594;4542.636589072867;4575.176468235716;4587.518310577408;6273.404026617464;6276.592021518587;6291.6854157291955;6326.272478664966;6388.55280130391;5797.217375654275;5811.738471768738;5820.35976042635;5859.619124756877;5868.735906884201;6657.167854018247;6686.465082793365;6710.899336509956;6738.4609231261875;6745.12313399255;4915.287283343895;4947.158982972867;4947.678400903929;4969.950300496985;4982.352294201767;6767.932320676779;6929.272426395206;6941.305869413069;6974.163100427931;7004.334588214111;4944.728039957837;4949.48030456804;4960.652754307236;4967.975160124249;5004.799808007639;5010.824621138243;5012.1980483122525;5041.495850415003;5061.468545802712;5078.873028174251;5655.208270842003;5665.688387138747;5687.289088863892;5724.599278050579;5762.567807414377;6716.1604799400075;6723.596584204964;6732.326767323327;6751.763688270887;6782;1754.9996501993996;1772.5923037701143;1781.6792977263958;1785.5625371783997;1803.449947765944;1167.5971789732528;1226.920250183735;1233.3894722112611;1243.9378031098408;1244.0793812578627;5833.270841144857;5833.970830145822;5854.2389489366105;5955.702214889238;5957.41279215002;6668.499862510234;6700.463962882957;6855.012046506457;6877.793666189922;6882.518223724292;5846.41535846412;5883.205767221456;5902.61632993854;5959.642421454727;6030.306514750772;3610.2851145706104;3620.7827530348263;3635.690966267897;3636.7089683162626;3685.2261025184475;6507.511936604774;6611.66941652925;6637.834054148589;6690.866182676319;6725.63009034498;6992;7017.333353331425;7033.9296607033275;7112.857742845114;7133.179684336368;6601.207855057424;6611.73553057882;6612.570182937998;6671.799846004627;6796.111652547746;6797.422219111431;6858.897116543156;6933.687984040629;6937.7571784987285;6977.755778547727;6617.66911654425;6741.4382534636525;6762.289959554176;6770.593764374154;6869.656517174021;6627.1716035495565;6631.568948018364;6687.230968438692;6694.966525167343;6717.932820671731;5546.7781288748;5614.606977511535;5636.774529018793;5664.915026274692;5680.2615659965595;6680.231773346128;6789.978459585437;6807.21717002551;6905.585664860125;7015.438764898694;6528.836779080561;6573.079768832463;6712.160979877515;6758.189017317954;6771.796846094625;6735.114168032958;6743.2582415935185;6754.223264324665;6765.391114799691;6765.458763299022;6617.8014659560295;6635.606522630302;6651.800445986628;6658.43403310724;6662.766803161866;6642.269350371552;6688;6730.932690673227;6743.291954344723;6798.694058767466;6406.23125224976;6457.935420645734;6535.183102112236;6537.313582073813;6541.528156164824 11:18:03 INFO - PID 18290 | |5;yui.html;888.8711136885148;907.7140700679287;921.5208091792268;925.1765928323794;939.7744541310085;19015.334463293788;20030.69953950692;20062.398128056164;20207.898960505176;20214.191432342726;18504.444866654023;18739;18984.050797460142;19008.429747107573;19095.61808763824;940.0646356874919;945.678469320431;946.0870260198907;948.8102379524123;951.1962391778935;954.7756277274835;966.2077096780642;974.468914441631;974.5273542331963;976.3019441099613;1008.9445080520568;1011.7672935224903;1017.9338343007718;1019.1846522781782;1020.7907378987289;986.0632399220698;1004.8894621591692;1011.2617789014024;1020.214434885138;1020.7907378987289;734.1740541890373;739.8187444076182;743.2567432567432;743.5204293230836;743.6393349225622;19898.303559375352;20069;20104.29634962784;20194.596108077756;20195.394138175878;20857;22162.66755998645;22184.556308873893;22199.11307538861;22343.55312893733;17484.03837788921;17652.91173544124;17684.469465915914;17749.556261093578;17817.910910445495;3661.304352173105;3686.5760437549757;3686.8156592170553;3691.187938653492;3696.685781708558;138614.30692846572;139770;140582.29708851493;140664;141786;16434.342626294816;16963.406280780113;16995.150242487827;16999.49001529956;17041;29156;29231.707682923323;29862;29937.251568710522;30224.546631800542;8350.874736878952;8405.495670259805;8418.705345312885;8420.115887831813;8423.4945903246;3816.427535869642;3834.9424758628643;3877.379619260961;3895.435161901565;3905.3946638271113;5014.348134742533;5099.082165210298;5102.464241254689;5115.053715062651;5116.3348764661105;902.4179404284331;922.7693076730817;938.1650331205096;940.1867384712311;940.4216406909838;689.2487188964053;702.104816359136;713.370227225304;715.8174665460274;720.3732752505249;11737.530498779954;12241.20432171906;12302.446389912297;12494.562690305978;12708.159918655083;632.6299115017766;632.6583644831832;638.7923924724483;643.9066335381343;651.2835880531472;5761.423857614205;5804.65172089676;5885.970570147122;5898.64608123514;6014.849628759316;122571.38714306371;123862;124132.37933810274;124231.65961523248;126938.36530817472;104628;104876;110330;111457;115197.24013799276;94133;95068;95743.52128239314;97094.14529273649;98129.50935245278;12607.43266552989;12693.174943628635;13356.265405402795;13545.1195672281;13653;42712.35931461093;43162.13675726405;45033;45047.549524504335;45215.77392113018;76094.61952690422;78467;81357;81841.59079204565;82340.17659823564;18675.252989880253;18909.71635425497;19130.23479060822;19135.521611959255;19520.707189391887;21220.787792121882;22097.005634746154;22381.32856014322;22428;22867.19964801224;19464.416067517996;19719.112639931525;20088.79911200869;20121.195152194334;20182;19384;19620;19922.800771992675;20158.29445969384;20354;18148.364807231683;18282.817171828643;18409.53976150607;18504.259829607203;18994.335198267996;11816.70458238551;12057.758844823229;12089.69775755578;12398.318092504998;12688.746225075261;13731.382087805872;14011.789823152458;14091.718165636425;14361;14481.983669188872 11:18:03 INFO - PID 18290 | __end_tp_report 11:18:03 INFO - PID 18290 | __start_cc_report 11:18:03 INFO - PID 18290 | _x_x_mozilla_cycle_collect,369 11:18:03 INFO - PID 18290 | __end_cc_report 11:18:03 INFO - PID 18290 | __startTimestamp1504808283061__endTimestamp 11:18:03 INFO - PID 18290 | 11:18:03 INFO - PID 18290 | ------- Summary: start ------- 11:18:03 INFO - PID 18290 | Number of tests: 6 11:18:03 INFO - PID 18290 | 11:18:03 INFO - PID 18290 | [#0] dojo.html Cycles:165 Average:6336.70 Median:6585.93 stddev:748.24 (11.4%) stddev-sans-first:709.51 11:18:03 INFO - PID 18290 | Values: 3221.4 3252.0 3258.3 3258.7 3284.0 6286.4 6479.6 6514.8 6519.6 6541.0 6342.9 6435.2 6435.5 6442.7 6451.2 5854.7 5877.0 5906.1 5915.1 5950.0 5929.6 5933.3 5936.5 5945.0 5956.6 6015.4 6026.8 6039.8 6044.8 6050.6 5958.5 6013.7 6028.3 6049.2 6070.0 5740.3 5796.9 5924.5 5933.5 5992.3 6289.3 6318.5 6452.7 6455.0 6518.5 6912.5 6913.8 6990.4 7015.4 7025.4 6775.2 6834.1 6883.1 6894.5 6941.2 6298.7 6318.2 6327.5 6330.1 6339.2 6967.3 6976.4 6986.1 7077.5 7131.9 6756.7 6846.1 6865.2 6871.0 6890.6 6941.8 7008.9 7023.8 7033.6 7039.0 6876.4 6887.8 6901.5 6974.5 6984.4 6696.5 6761.6 6874.6 6962.4 6992.0 5451.2 5477.8 5480.5 5482.6 5486.2 4797.6 4827.4 4845.1 4847.2 4879.0 5796.3 6019.7 6028.0 6089.1 6105.2 6821.8 6853.8 6855.1 6867.0 6872.5 5922.8 5939.7 5940.4 5940.7 5951.3 5864.5 5880.4 5881.1 5907.3 6056.8 6090.2 6595.7 6598.6 6602.6 6630.2 6828.7 6839.0 6858.1 6861.0 6863.5 6596.0 6602.9 6615.4 6619.8 6757.8 6859.0 6884.1 6958.5 6961.8 6974.7 6794.2 6994.3 6998.8 7085.5 7097.8 6585.9 6603.9 6617.0 6617.5 6621.8 5708.5 6564.9 6612.9 6614.4 6832.9 6672.1 6680.5 6785.5 6785.9 6789.8 6615.3 6689.4 6730.0 6810.6 6873.1 6371.5 6373.0 6388.9 6500.9 6600.4 11:18:03 INFO - PID 18290 | 11:18:03 INFO - PID 18290 | [#1] ext.html Cycles:180 Average:38900.07 Median:37277.04 stddev:56522.94 (151.6%) stddev-sans-first:56609.29 11:18:03 INFO - PID 18290 | Values: 848.7 860.6 870.4 870.5 879.9 39519.0 43150.6 43583.6 43831.1 43841.1 39603.8 39886.8 39955.0 40091.4 40101.6 6995.9 7133.5 7623.7 7849.0 7894.6 7679.2 7794.8 7795.5 7796.5 7807.3 7794.3 7832.9 7869.5 7874.6 7885.3 7703.2 7732.0 7733.8 7780.0 7814.0 7614.8 7689.5 7690.0 7699.7 7718.1 37930.8 38215.0 38265.6 38481.0 38646.0 3445.5 3493.1 3495.1 3499.4 3500.9 30239.0 30365.2 30419.7 30554.7 30826.7 4864.7 4993.8 5044.8 5082.8 5106.4 178772.0 178953.0 179178.0 180328.0 180451.0 40967.0 41998.4 46640.3 46933.3 47203.0 50242.0 50951.0 50997.5 50997.7 51370.9 15866.6 16014.8 16033.0 16054.2 16065.0 13250.9 13261.5 13288.5 13290.8 13296.9 13670.7 13772.4 13790.6 13848.4 13954.7 5477.4 5553.8 5587.6 5596.9 5792.5 991.1 1011.0 1015.8 1019.2 1028.8 22823.9 29351.4 29702.3 30191.4 30507.7 1101.4 1104.5 1105.4 1113.1 1115.0 12386.9 12769.4 12813.6 12880.4 13030.9 251522.0 253770.0 255002.0 255106.0 255646.0 53528.7 53658.2 54026.7 54151.5 54312.5 1404.8 1437.1 1459.1 1459.2 1459.4 22806.4 22943.0 22985.5 23087.3 23480.3 37986.0 38124.8 38214.8 38261.6 38337.4 212518.0 213101.0 213533.0 213702.0 213992.0 34027.7 36623.3 38405.2 38528.0 38547.8 45858.0 46418.5 46796.0 46821.0 46865.8 33757.7 33829.3 34444.8 34473.5 34658.3 33710.2 33810.3 33927.5 33958.0 34788.1 38845.4 39177.8 39275.6 39417.2 39543.6 33362.0 33517.8 33533.2 33605.7 34386.0 23603.5 24328.6 24648.0 24787.5 25034.9 11:18:03 INFO - PID 18290 | 11:18:03 INFO - PID 18290 | [#2] jquery.html Cycles:180 Average:36059.49 Median:22419.11 stddev:88872.01 (396.4%) stddev-sans-first:89081.30 11:18:03 INFO - PID 18290 | Values: 540.3 564.8 570.3 578.1 588.4 22211.3 22838.3 22856.3 22914.3 22935.8 23429.6 24233.0 24528.8 24797.1 25087.2 6323.4 6404.2 6451.8 6455.6 6486.5 6291.2 6365.3 6463.0 6466.5 6474.8 6504.7 6525.0 6529.3 6559.9 6563.0 6540.7 6541.7 6549.5 6553.5 6556.9 5737.8 5929.8 5961.3 5978.5 5978.6 28213.7 28554.7 28637.3 28672.9 28675.7 2008.5 2031.6 2034.7 2042.3 2045.1 18921.4 18923.6 19346.5 19476.8 19533.2 2359.5 2401.3 2453.4 2455.2 2466.1 123192.4 129205.0 137558.0 140414.3 143844.0 14249.8 14354.9 14523.6 14813.1 14859.4 22171.4 22414.2 22424.0 22486.2 22489.7 10240.8 10265.2 10277.9 10355.5 10400.4 9787.7 9805.5 9815.5 9847.6 9880.2 8836.7 8877.3 9087.4 9138.1 9222.5 2632.3 2674.2 2747.3 2748.0 2774.2 955.2 955.8 959.5 969.2 971.5 18514.9 18670.8 18734.9 18744.2 19125.8 1020.7 1028.9 1032.8 1035.7 1037.0 10414.2 10479.6 10506.5 10558.8 10719.4 465776.0 541175.9 543735.0 544784.0 545627.0 119163.0 125000.0 125232.4 125538.0 127243.0 1156.1 1201.5 1224.7 1239.4 1244.6 19828.4 19915.7 20210.5 20306.7 20311.9 58943.1 60749.0 60986.0 61195.0 61385.7 74062.0 74375.0 74650.6 74750.0 76351.2 13725.4 14108.9 14111.8 14112.2 14113.3 22022.8 22383.1 22388.2 22484.6 22554.5 17525.8 17764.5 17835.3 17887.6 17903.0 15767.8 16065.3 16255.8 16389.3 16478.8 18507.3 18685.2 18688.4 18719.2 18918.2 13677.3 14309.5 14497.6 14508.5 14539.3 18281.4 18506.4 18520.7 18550.7 18589.7 11:18:03 INFO - PID 18290 | 11:18:03 INFO - PID 18290 | [#3] mootools.html Cycles:180 Average:9481.11 Median:2707.01 stddev:6826.58 (252.2%) stddev-sans-first:6818.33 11:18:03 INFO - PID 18290 | Values: 1341.5 1383.7 1383.7 1386.6 1389.8 14649.6 15290.2 15347.9 15358.1 15662.2 15534.4 15772.8 15851.9 15853.2 15856.3 2724.2 2793.6 2820.9 2821.2 2872.5 2788.8 2804.0 2815.0 2816.3 2818.4 2786.2 2834.4 2835.5 2835.8 2836.0 2721.3 2734.3 2735.8 2741.3 2744.5 2684.7 2707.0 2707.0 2707.3 2709.1 14847.7 14967.2 15192.1 15307.7 15319.3 7773.8 8140.3 8142.1 8142.1 8142.5 5379.5 5633.2 5751.2 5802.7 5806.5 1895.4 1923.0 1924.6 1972.2 1989.2 26690.1 26913.3 26978.9 27051.5 27189.5 6794.7 6820.4 6909.7 6949.5 7027.2 17131.5 17255.6 17270.1 17289.4 17294.9 7609.7 7709.7 7715.3 7716.2 7721.3 5906.9 6000.9 6292.6 6295.0 7468.8 5246.3 5379.8 5380.1 5469.5 5609.6 1559.1 1575.6 1575.9 1589.9 1609.7 895.8 912.9 916.5 916.8 928.1 7586.8 7692.0 7721.5 7792.3 7818.0 713.0 718.1 726.6 729.9 740.5 4545.0 4551.3 4714.1 4990.4 5195.4 20647.7 22283.8 22489.3 22490.1 22491.7 21289.7 21496.8 22005.0 22170.3 22182.4 11300.3 11636.5 11735.4 11764.5 11778.5 8547.6 8816.7 8892.0 9090.5 9158.6 18656.8 19092.0 19228.2 19487.7 19709.7 19097.3 19336.9 19468.0 19543.5 19849.5 12112.5 12258.9 12379.4 12388.1 12388.9 14153.3 14223.2 14257.0 14261.6 14263.4 11377.5 11420.9 11428.5 11520.2 11752.8 10953.9 11204.7 11347.8 11481.3 11499.1 10378.3 10589.5 10601.1 10602.5 10607.4 7249.3 7269.6 7282.6 7300.5 7304.1 7485.6 7505.0 7547.4 7566.5 7587.7 11:18:03 INFO - PID 18290 | 11:18:03 INFO - PID 18290 | [#4] prototype.html Cycles:180 Average:5650.79 Median:6396.38 stddev:1586.24 (24.8%) stddev-sans-first:1543.00 11:18:03 INFO - PID 18290 | Values: 507.6 520.2 521.2 531.5 533.2 6472.0 6487.9 6491.2 6512.4 6563.0 6249.8 6404.2 6414.8 6459.6 6474.0 5288.8 5289.9 5297.7 5303.0 5339.8 4907.7 5208.5 5233.6 5259.7 5336.9 4925.3 5024.6 5032.5 5069.2 5076.4 5015.9 5047.0 5103.5 5114.0 5121.8 4516.0 4533.8 4542.6 4575.2 4587.5 6273.4 6276.6 6291.7 6326.3 6388.6 5797.2 5811.7 5820.4 5859.6 5868.7 6657.2 6686.5 6710.9 6738.5 6745.1 4915.3 4947.2 4947.7 4970.0 4982.4 6767.9 6929.3 6941.3 6974.2 7004.3 4944.7 4949.5 4960.7 4968.0 5004.8 5010.8 5012.2 5041.5 5061.5 5078.9 5655.2 5665.7 5687.3 5724.6 5762.6 6716.2 6723.6 6732.3 6751.8 6782.0 1755.0 1772.6 1781.7 1785.6 1803.4 1167.6 1226.9 1233.4 1243.9 1244.1 5833.3 5834.0 5854.2 5955.7 5957.4 6668.5 6700.5 6855.0 6877.8 6882.5 5846.4 5883.2 5902.6 5959.6 6030.3 3610.3 3620.8 3635.7 3636.7 3685.2 6507.5 6611.7 6637.8 6690.9 6725.6 6992.0 7017.3 7033.9 7112.9 7133.2 6601.2 6611.7 6612.6 6671.8 6796.1 6797.4 6858.9 6933.7 6937.8 6977.8 6617.7 6741.4 6762.3 6770.6 6869.7 6627.2 6631.6 6687.2 6695.0 6717.9 5546.8 5614.6 5636.8 5664.9 5680.3 6680.2 6790.0 6807.2 6905.6 7015.4 6528.8 6573.1 6712.2 6758.2 6771.8 6735.1 6743.3 6754.2 6765.4 6765.5 6617.8 6635.6 6651.8 6658.4 6662.8 6642.3 6688.0 6730.9 6743.3 6798.7 6406.2 6457.9 6535.2 6537.3 6541.5 11:18:03 INFO - PID 18290 | 11:18:03 INFO - PID 18290 | [#5] yui.html Cycles:180 Average:25706.26 Median:21658.90 stddev:36178.24 (167.0%) stddev-sans-first:36231.73 11:18:03 INFO - PID 18290 | Values: 888.9 907.7 921.5 925.2 939.8 19015.3 20030.7 20062.4 20207.9 20214.2 18504.4 18739.0 18984.1 19008.4 19095.6 940.1 945.7 946.1 948.8 951.2 954.8 966.2 974.5 974.5 976.3 1008.9 1011.8 1017.9 1019.2 1020.8 986.1 1004.9 1011.3 1020.2 1020.8 734.2 739.8 743.3 743.5 743.6 19898.3 20069.0 20104.3 20194.6 20195.4 20857.0 22162.7 22184.6 22199.1 22343.6 17484.0 17652.9 17684.5 17749.6 17817.9 3661.3 3686.6 3686.8 3691.2 3696.7 138614.3 139770.0 140582.3 140664.0 141786.0 16434.3 16963.4 16995.2 16999.5 17041.0 29156.0 29231.7 29862.0 29937.3 30224.5 8350.9 8405.5 8418.7 8420.1 8423.5 3816.4 3834.9 3877.4 3895.4 3905.4 5014.3 5099.1 5102.5 5115.1 5116.3 902.4 922.8 938.2 940.2 940.4 689.2 702.1 713.4 715.8 720.4 11737.5 12241.2 12302.4 12494.6 12708.2 632.6 632.7 638.8 643.9 651.3 5761.4 5804.7 5886.0 5898.6 6014.8 122571.4 123862.0 124132.4 124231.7 126938.4 104628.0 104876.0 110330.0 111457.0 115197.2 94133.0 95068.0 95743.5 97094.1 98129.5 12607.4 12693.2 13356.3 13545.1 13653.0 42712.4 43162.1 45033.0 45047.5 45215.8 76094.6 78467.0 81357.0 81841.6 82340.2 18675.3 18909.7 19130.2 19135.5 19520.7 21220.8 22097.0 22381.3 22428.0 22867.2 19464.4 19719.1 20088.8 20121.2 20182.0 19384.0 19620.0 19922.8 20158.3 20354.0 18148.4 18282.8 18409.5 18504.3 18994.3 11816.7 12057.8 12089.7 12398.3 12688.7 13731.4 14011.8 14091.7 14361.0 14482.0 11:18:03 INFO - PID 18290 | -------- Summary: end -------- 11:18:03 INFO - PID 18290 | 11:18:03 INFO - TEST-INFO | 18290: exit 0 11:18:03 INFO - TEST-OK | dromaeo_css | took 1108869ms 11:18:03 INFO - TEST-START | kraken 11:18:03 INFO - Initialising browser for kraken test... 11:18:03 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:52330/getInfo.html -profile /tmp/tmpjHoOKJ/profile 11:18:03 INFO - TEST-INFO | started process 18667 (/builds/slave/test/build/application/firefox/firefox http://localhost:52330/getInfo.html) 11:18:08 INFO - TEST-INFO | 18667: exit 0 11:18:08 INFO - Browser initialized. 11:18:08 INFO - Running cycle 1/1 for kraken test... 11:18:08 INFO - Using env: {'DISPLAY': ':0', 11:18:08 INFO - 'HOME': '/home/cltbld', 11:18:08 INFO - 'JSGC_DISABLE_POISONING': '1', 11:18:08 INFO - 'LANG': 'en_US.UTF-8', 11:18:08 INFO - 'LANGUAGE': 'en_US:en', 11:18:08 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:18:08 INFO - 'LOGNAME': 'cltbld', 11:18:08 INFO - 'MAIL': '/var/mail/cltbld', 11:18:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:18:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:18:08 INFO - 'MOZ_CRASHREPORTER': '1', 11:18:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:08 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:18:08 INFO - 'MOZ_NO_REMOTE': '1', 11:18:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:18:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:08 INFO - 'NO_EM_RESTART': '1', 11:18:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:08 INFO - 'PWD': '/builds/slave/test', 11:18:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:18:08 INFO - 'RUST_BACKTRACE': 'full', 11:18:08 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:18:08 INFO - 'SHELL': '/bin/bash', 11:18:08 INFO - 'SHLVL': '1', 11:18:08 INFO - 'STYLO_FORCE_ENABLED': '1', 11:18:08 INFO - 'STYLO_THREADS': '1', 11:18:08 INFO - 'TERM': 'linux', 11:18:08 INFO - 'TMOUT': '86400', 11:18:08 INFO - 'USER': 'cltbld', 11:18:08 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1504807105.814051-1321574702', 11:18:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:08 INFO - '_': '/tools/buildbot/bin/python'} 11:18:08 INFO - TEST-INFO | started process 18847 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjHoOKJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:18:09 INFO - PID 18847 | 11:18:09 INFO - PID 18847 | (/builds/slave/test/build/application/firefox/firefox:18898): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:18:09 INFO - PID 18847 | 11:18:19 INFO - PID 18847 | RSS: Main: 171991040 11:18:19 INFO - PID 18847 | 11:18:22 INFO - PID 18847 | Cycle 1(1): loaded http://localhost:52330/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52330/tests/kraken/driver.html?testName=audio-beat-detection) 11:18:23 INFO - PID 18847 | RSS: Main: 177946624 11:18:23 INFO - PID 18847 | 11:18:26 INFO - PID 18847 | Cycle 1(1): loaded http://localhost:52330/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52330/tests/kraken/driver.html?testName=audio-dft) 11:18:26 INFO - PID 18847 | RSS: Main: 178479104 11:18:26 INFO - PID 18847 | 11:18:29 INFO - PID 18847 | Cycle 1(1): loaded http://localhost:52330/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52330/tests/kraken/driver.html?testName=audio-fft) 11:18:30 INFO - PID 18847 | RSS: Main: 173068288 11:18:30 INFO - PID 18847 | 11:18:32 INFO - PID 18847 | Cycle 1(1): loaded http://localhost:52330/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52330/tests/kraken/driver.html?testName=audio-oscillator) 11:18:33 INFO - PID 18847 | RSS: Main: 173662208 11:18:33 INFO - PID 18847 | 11:18:35 INFO - PID 18847 | Cycle 1(1): loaded http://localhost:52330/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52330/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:18:35 INFO - PID 18847 | RSS: Main: 173928448 11:18:35 INFO - PID 18847 | 11:18:39 INFO - PID 18847 | Cycle 1(1): loaded http://localhost:52330/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52330/tests/kraken/driver.html?testName=imaging-darkroom) 11:18:39 INFO - PID 18847 | RSS: Main: 176185344 11:18:39 INFO - PID 18847 | 11:18:43 INFO - PID 18847 | Cycle 1(1): loaded http://localhost:52330/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52330/tests/kraken/driver.html?testName=imaging-desaturate) 11:18:43 INFO - PID 18847 | RSS: Main: 175910912 11:18:43 INFO - PID 18847 | 11:18:46 INFO - PID 18847 | Cycle 1(1): loaded http://localhost:52330/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52330/tests/kraken/driver.html?testName=json-parse-financial) 11:18:47 INFO - PID 18847 | RSS: Main: 176599040 11:18:47 INFO - PID 18847 | 11:18:49 INFO - PID 18847 | Cycle 1(1): loaded http://localhost:52330/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52330/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:18:49 INFO - PID 18847 | RSS: Main: 176824320 11:18:49 INFO - PID 18847 | 11:18:51 INFO - PID 18847 | Cycle 1(1): loaded http://localhost:52330/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52330/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:18:51 INFO - PID 18847 | RSS: Main: 176779264 11:18:51 INFO - PID 18847 | 11:18:54 INFO - PID 18847 | Cycle 1(1): loaded http://localhost:52330/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52330/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:18:54 INFO - PID 18847 | RSS: Main: 173625344 11:18:54 INFO - PID 18847 | 11:18:57 INFO - PID 18847 | Cycle 1(1): loaded http://localhost:52330/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52330/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:18:58 INFO - PID 18847 | RSS: Main: 174354432 11:18:58 INFO - PID 18847 | 11:19:01 INFO - PID 18847 | Cycle 1(1): loaded http://localhost:52330/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52330/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:19:01 INFO - PID 18847 | RSS: Main: 174092288 11:19:01 INFO - PID 18847 | 11:19:03 INFO - PID 18847 | Cycle 1(1): loaded http://localhost:52330/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52330/tests/kraken/driver.html?testName=ai-astar) 11:19:03 INFO - PID 18847 | RSS: Main: 175935488 11:19:03 INFO - PID 18847 | 11:19:03 INFO - PID 18847 | __start_tp_report 11:19:03 INFO - PID 18847 | _x_x_mozilla_page_load 11:19:03 INFO - PID 18847 | _x_x_mozilla_page_load_details 11:19:03 INFO - PID 18847 | |i|pagename|runs| 11:19:03 INFO - PID 18847 | |0;ai-astar;108;108;107;106;108;96;108;110;108;109 11:19:03 INFO - PID 18847 | |1;audio-beat-detection;120;120;116;119;116;123;141;133;128;121 11:19:03 INFO - PID 18847 | |2;audio-dft;164;163;164;163;164;162;164;171;165;162 11:19:03 INFO - PID 18847 | |3;audio-fft;74;74;73;73;74;74;77;77;76;75 11:19:03 INFO - PID 18847 | |4;audio-oscillator;80;80;86;86;79;78;79;80;85;79 11:19:03 INFO - PID 18847 | |5;imaging-gaussian-blur;113;114;114;114;114;114;113;117;114;119 11:19:03 INFO - PID 18847 | |6;imaging-darkroom;148;148;148;148;147;147;147;149;147;151 11:19:03 INFO - PID 18847 | |7;imaging-desaturate;94;94;94;99;98;94;93;95;94;94 11:19:03 INFO - PID 18847 | |8;json-parse-financial;52;56;51;57;52;52;59;51;52;51 11:19:03 INFO - PID 18847 | |9;json-stringify-tinderbox;39;38;38;37;37;39;38;38;38;38 11:19:03 INFO - PID 18847 | |10;stanford-crypto-aes;74;75;76;74;77;74;77;75;74;75 11:19:03 INFO - PID 18847 | |11;stanford-crypto-ccm;118;125;124;117;115;130;118;115;129;126 11:19:03 INFO - PID 18847 | |12;stanford-crypto-pbkdf2;171;170;180;170;172;176;176;169;176;170 11:19:03 INFO - PID 18847 | |13;stanford-crypto-sha256-iterative;64;64;65;65;64;66;63;63;68;68 11:19:03 INFO - PID 18847 | __end_tp_report 11:19:03 INFO - PID 18847 | __start_cc_report 11:19:03 INFO - PID 18847 | _x_x_mozilla_cycle_collect,927 11:19:03 INFO - PID 18847 | __end_cc_report 11:19:03 INFO - PID 18847 | __startTimestamp1504808343695__endTimestamp 11:19:03 INFO - PID 18847 | 11:19:03 INFO - PID 18847 | ------- Summary: start ------- 11:19:03 INFO - PID 18847 | Number of tests: 14 11:19:03 INFO - PID 18847 | 11:19:03 INFO - PID 18847 | [#0] ai-astar Cycles:10 Average:106.80 Median:108.00 stddev:3.94 (3.6%) stddev-sans-first:4.15 11:19:03 INFO - PID 18847 | Values: 108.0 108.0 107.0 106.0 108.0 96.0 108.0 110.0 108.0 109.0 11:19:03 INFO - PID 18847 | 11:19:03 INFO - PID 18847 | [#1] audio-beat-detection Cycles:10 Average:123.70 Median:122.00 stddev:8.03 (6.6%) stddev-sans-first:8.40 11:19:03 INFO - PID 18847 | Values: 120.0 120.0 116.0 119.0 116.0 123.0 141.0 133.0 128.0 121.0 11:19:03 INFO - PID 18847 | 11:19:03 INFO - PID 18847 | [#2] audio-dft Cycles:10 Average:164.20 Median:164.00 stddev:2.57 (1.6%) stddev-sans-first:2.73 11:19:03 INFO - PID 18847 | Values: 164.0 163.0 164.0 163.0 164.0 162.0 164.0 171.0 165.0 162.0 11:19:03 INFO - PID 18847 | 11:19:03 INFO - PID 18847 | [#3] audio-fft Cycles:10 Average:74.70 Median:74.50 stddev:1.49 (2.0%) stddev-sans-first:1.56 11:19:03 INFO - PID 18847 | Values: 74.0 74.0 73.0 73.0 74.0 74.0 77.0 77.0 76.0 75.0 11:19:03 INFO - PID 18847 | 11:19:03 INFO - PID 18847 | [#4] audio-oscillator Cycles:10 Average:81.20 Median:80.00 stddev:3.16 (3.9%) stddev-sans-first:3.32 11:19:03 INFO - PID 18847 | Values: 80.0 80.0 86.0 86.0 79.0 78.0 79.0 80.0 85.0 79.0 11:19:03 INFO - PID 18847 | 11:19:03 INFO - PID 18847 | [#5] imaging-gaussian-blur Cycles:10 Average:114.60 Median:114.00 stddev:1.90 (1.7%) stddev-sans-first:1.92 11:19:03 INFO - PID 18847 | Values: 113.0 114.0 114.0 114.0 114.0 114.0 113.0 117.0 114.0 119.0 11:19:03 INFO - PID 18847 | 11:19:03 INFO - PID 18847 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:1.25 (0.8%) stddev-sans-first:1.32 11:19:03 INFO - PID 18847 | Values: 148.0 148.0 148.0 148.0 147.0 147.0 147.0 149.0 147.0 151.0 11:19:03 INFO - PID 18847 | 11:19:03 INFO - PID 18847 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:94.00 stddev:1.97 (2.1%) stddev-sans-first:2.06 11:19:03 INFO - PID 18847 | Values: 94.0 94.0 94.0 99.0 98.0 94.0 93.0 95.0 94.0 94.0 11:19:03 INFO - PID 18847 | 11:19:03 INFO - PID 18847 | [#8] json-parse-financial Cycles:10 Average:53.30 Median:52.00 stddev:2.91 (5.6%) stddev-sans-first:3.05 11:19:03 INFO - PID 18847 | Values: 52.0 56.0 51.0 57.0 52.0 52.0 59.0 51.0 52.0 51.0 11:19:03 INFO - PID 18847 | 11:19:03 INFO - PID 18847 | [#9] json-stringify-tinderbox Cycles:10 Average:38.00 Median:38.00 stddev:0.67 (1.8%) stddev-sans-first:0.60 11:19:03 INFO - PID 18847 | Values: 39.0 38.0 38.0 37.0 37.0 39.0 38.0 38.0 38.0 38.0 11:19:03 INFO - PID 18847 | 11:19:03 INFO - PID 18847 | [#10] stanford-crypto-aes Cycles:10 Average:75.10 Median:75.00 stddev:1.20 (1.6%) stddev-sans-first:1.20 11:19:03 INFO - PID 18847 | Values: 74.0 75.0 76.0 74.0 77.0 74.0 77.0 75.0 74.0 75.0 11:19:03 INFO - PID 18847 | 11:19:03 INFO - PID 18847 | [#11] stanford-crypto-ccm Cycles:10 Average:121.70 Median:124.50 stddev:5.74 (4.6%) stddev-sans-first:5.93 11:19:03 INFO - PID 18847 | Values: 118.0 125.0 124.0 117.0 115.0 130.0 118.0 115.0 129.0 126.0 11:19:03 INFO - PID 18847 | 11:19:03 INFO - PID 18847 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.00 Median:174.00 stddev:3.71 (2.1%) stddev-sans-first:3.87 11:19:03 INFO - PID 18847 | Values: 171.0 170.0 180.0 170.0 172.0 176.0 176.0 169.0 176.0 170.0 11:19:03 INFO - PID 18847 | 11:19:03 INFO - PID 18847 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.00 Median:65.00 stddev:1.83 (2.8%) stddev-sans-first:1.90 11:19:03 INFO - PID 18847 | Values: 64.0 64.0 65.0 65.0 64.0 66.0 63.0 63.0 68.0 68.0 11:19:03 INFO - PID 18847 | -------- Summary: end -------- 11:19:03 INFO - PID 18847 | 11:19:04 INFO - PID 18847 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:19:04 INFO - TEST-INFO | 18847: exit 0 11:19:04 INFO - TEST-OK | kraken | took 60658ms 11:19:04 INFO - SUITE-END | took 1169s 11:19:04 INFO - Completed test suite (00:19:29) 11:19:04 INFO - javascript benchmark 11:19:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8675.14777280323, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3221.420144374013, 3252.0, 3258.2831777009064, 3258.6741325867415, 3284.0312107928157, 6286.3713628637115, 6479.578827376217, 6514.80455586332, 6519.641419721914, 6541.0, 6342.936570634292, 6435.227772667275, 6435.452986496141, 6442.742290308393, 6451.225852897647, 5854.707264636772, 5877.0009098453365, 5906.084556893688, 5915.053591425372, 5950.04799232123, 5929.584929054968, 5933.317668468117, 5936.5250779937505, 5945.0, 5956.612820166697, 6015.428534289235, 6026.789062382817, 6039.758409663608, 6044.788432404866, 6050.638606313566, 5958.523318134538, 6013.669248191348, 6028.336882942873, 6049.243844519435, 6069.999999999955, 5740.311162660466, 5796.942030579725, 5924.496417804492, 5933.4659880610525, 5992.34084250732, 6289.308176100625, 6318.526110541728, 6452.7418903243815, 6455.031745238205, 6518.543701940866, 6912.4815638826785, 6913.792586222421, 6990.440764738809, 7015.4036906862975, 7025.402840758542, 6775.22084960226, 6834.1457317835275, 6883.139607549057, 6894.517383783137, 6941.201761797407, 6298.7480500780375, 6318.241810982711, 6327.46216571592, 6330.145430366888, 6339.175907132043, 6967.268436814163, 6976.372126508537, 6986.091808065021, 7077.469189810785, 7131.857362852714, 6756.662166891636, 6846.144231971004, 6865.244823069458, 6871.03805467235, 6890.621015844176, 6941.826454338682, 7008.929910700827, 7023.824404389931, 7033.577985320897, 7039.0, 6876.449884009267, 6887.827804304932, 6901.516893817385, 6974.476914231453, 6984.406325462291, 6696.46428285736, 6761.628110453874, 6874.621895795779, 6962.373386395248, 6991.965040174767, 5451.236826844245, 5477.780888764405, 5480.506754392124, 5482.5613950883835, 5486.177073439016, 4797.64017698674, 4827.372441582642, 4845.079434907357, 4847.175980083394, 4878.9512104878495, 5796.304443466811, 6019.729112189962, 6027.969860150672, 6089.117078023662, 6105.206323178048, 6821.829454263683, 6853.828654283583, 6855.07456493377, 6867.0, 6872.518923675295, 5922.763089476372, 5939.673317967553, 5940.435658612425, 5940.673262970492, 5951.256092988377, 5864.47219750216, 5880.411958804086, 5881.1178323251, 5907.261592300963, 6056.757729690763, 6090.23872015998, 6595.70319335631, 6598.60408375499, 6602.636854973022, 6630.237522684856, 6828.658567071726, 6839.0, 6858.142732158481, 6861.039454476477, 6863.519553631198, 6595.967020164869, 6602.8679426410245, 6615.4376877965915, 6619.7683081093855, 6757.763478278237, 6859.0, 6884.105066341343, 6958.512904096665, 6961.756338528127, 6974.651267436507, 6794.150731158606, 6994.300569942965, 6998.825029374103, 7085.504014719127, 7097.751578694721, 6585.934140658724, 6603.867922641616, 6617.007448882706, 6617.536772426077, 6621.801345959629, 5708.514776244066, 6564.868702625825, 6612.933870661424, 6614.437772789367, 6832.863342733018, 6672.065910772592, 6680.5323627345615, 6785.5250132490255, 6785.93214067853, 6789.830254243683, 6615.305392933673, 6689.397954184147, 6730.0, 6810.62541560219, 6873.140857392826, 6371.49028077762, 6373.044043393343, 6388.9041664374145, 6500.869982600416, 6600.372964568358], "value": 6281.212989773773, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [848.7114381110423, 860.6299291304745, 870.4168207301108, 870.4646642314979, 879.9164079412456, 39519.0, 43150.56849431505, 43583.564164358344, 43831.12337753247, 43841.12317753643, 39603.80198099006, 39886.800565997204, 39955.0, 40091.39862902059, 40101.598984010154, 6995.895061574068, 7133.464990125735, 7623.656935437919, 7849.0, 7894.60526973649, 7679.232076792332, 7794.844103117963, 7795.493292935969, 7796.454248202628, 7807.297343239107, 7794.337481314095, 7832.921670783277, 7869.48848324857, 7874.5668988205625, 7885.329746971514, 7703.191164927686, 7731.961340193319, 7733.8066548336465, 7780.027496562958, 7813.96093019537, 7614.8197029460525, 7689.538627682357, 7690.0, 7699.6920123195005, 7718.073831140299, 37930.81034594837, 38215.04462388463, 38265.61734382648, 38481.0, 38646.0, 3445.534852794866, 3493.1441796759955, 3495.0563347895927, 3499.3526197653514, 3500.8949731508096, 30239.0, 30365.24086897823, 30419.69580304191, 30554.69445305563, 30826.691733082607, 4864.708117512961, 4993.775280112403, 5044.798208071673, 5082.771275292584, 5106.412762532319, 178772.0, 178953.0, 179178.0, 180328.0, 180451.0, 40967.0, 41998.37002444966, 46640.30039549342, 46933.29600056002, 47203.0, 50242.0, 50951.0, 50997.490025100014, 50997.7450112747, 51370.917744935425, 15866.603334916488, 16014.839851601335, 16033.038017718975, 16054.197290135446, 16065.0, 13250.933745331404, 13261.469541218436, 13288.468461261635, 13290.800637990438, 13296.867031329562, 13670.658233544242, 13772.449102036007, 13790.586282411543, 13848.446062157402, 13954.651133721738, 5477.397486276506, 5553.805616803393, 5587.608867379245, 5596.944030559724, 5792.536597072224, 991.1129539062642, 1010.9747256318503, 1015.7968406318765, 1019.1642852860583, 1028.7788125553043, 22823.88588057049, 29351.412971740447, 29702.257443564085, 30191.396172076875, 30507.69492305093, 1101.4492753623188, 1104.5416152296868, 1105.4472763618191, 1113.0983903038402, 1114.9721256968642, 12386.938065309616, 12769.425375858109, 12813.551525696555, 12880.420381082873, 13030.934845325713, 251522.0, 253770.0, 255002.0, 255106.0, 255646.0, 53528.73235633797, 53658.19512707312, 54026.72986635042, 54151.45848541543, 54312.45687543153, 1404.8243969503812, 1437.0515459796484, 1459.073488334915, 1459.2484870291808, 1459.3578825316827, 22806.429839254153, 22943.0, 22985.54028919379, 23087.307380778602, 23480.295591132293, 37986.0, 38124.809375952944, 38214.80892595519, 38261.617383825804, 38337.42493862539, 212518.0, 213101.0, 213533.0, 213702.0, 213992.0, 34027.65972340245, 36623.26753464969, 38405.23189536249, 38528.0, 38547.80726096351, 45858.0, 46418.53581464142, 46796.0, 46821.0, 46865.76567117142, 33757.66242337545, 33829.3234135311, 34444.82777586096, 34473.48289775706, 34658.30683386369, 33710.157246069044, 33810.32379352448, 33927.4910876342, 33958.0, 34788.130296742784, 38845.44618215353, 39177.80411097926, 39275.607243927196, 39417.21165576615, 39543.604563953995, 33362.0, 33517.83241083779, 33533.16167095842, 33605.66394336123, 34386.0, 23603.527929441658, 24328.635070474313, 24648.0, 24787.504249915262, 25034.874825625757], "value": 17492.510882089602, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [540.2619031097277, 564.7515093358925, 570.3355590736792, 578.1443463673761, 588.370443625321, 22211.333659990185, 22838.314850554467, 22856.31431057067, 22914.312570622867, 22935.770642293573, 23429.64855527164, 24233.0, 24528.754712452872, 24797.13210037649, 25087.247382578505, 6323.367663233675, 6404.23149222094, 6451.806445806634, 6455.61266324022, 6486.545941784077, 6291.245050593935, 6365.331640177784, 6463.0, 6466.515011374142, 6474.805755827333, 6504.70728817202, 6525.0, 6529.34706529348, 6559.901601475982, 6563.01554766784, 6540.672966351711, 6541.705623246965, 6549.541532092755, 6553.50848686348, 6556.868862622769, 5737.799177028825, 5929.792457264019, 5961.2846458425265, 5978.521718262572, 5978.581499295051, 28213.717862821315, 28554.714452855413, 28637.28406789826, 28672.85663571669, 28675.71324286772, 2008.4878356019267, 2031.5530583271657, 2034.6846238833004, 2042.3158241988951, 2045.079714128648, 18921.432357029313, 18923.62152756951, 19346.516337091543, 19476.80523194764, 19533.218671253133, 2359.504504054151, 2401.3396316013063, 2453.386653336666, 2455.226603619854, 2466.0505705303585, 123192.38403808013, 129205.0, 137558.0, 140414.29792851073, 143844.0, 14249.783132296561, 14354.927326307336, 14523.564293071226, 14813.114655942481, 14859.427714607022, 22171.445713857283, 22414.215502457337, 22424.0, 22486.212982545534, 22489.662655060187, 10240.846387304196, 10265.178785697126, 10277.897221027844, 10355.534000969974, 10400.427976461368, 9787.706368808947, 9805.509724513746, 9815.460149691693, 9847.556859941176, 9880.209583233467, 8836.690715824916, 8877.279389039039, 9087.409318394282, 9138.13187747163, 9222.492762897971, 2632.2761240658588, 2674.1576403432855, 2747.2719729271757, 2747.986260068687, 2774.1677496750895, 955.2310390136007, 955.7766059443923, 959.467495539968, 969.185883857563, 971.455984648599, 18514.907425462785, 18670.813291866907, 18734.906325468284, 18744.222072308476, 19125.808741912402, 1020.7295066807302, 1028.927975041755, 1032.7986042721598, 1035.7255327338262, 1036.9740756480996, 10414.166866650801, 10479.633212837667, 10506.474676266156, 10558.788824223473, 10719.410432426292, 465776.0, 541175.8823617649, 543735.0, 544784.0, 545627.0, 119163.0, 125000.0, 125232.37383813022, 125538.0, 127243.0, 1156.1329003247565, 1201.5101274419483, 1224.7244370016674, 1239.3803098450774, 1244.6266120163914, 19828.405147845588, 19915.701264480755, 20210.494737631678, 20306.69539956872, 20311.898440507703, 58943.115853263094, 60749.0, 60986.0, 61195.0, 61385.693071534355, 74062.0, 74375.0, 74650.62674686592, 74750.0, 76351.2364876344, 13725.382357793724, 14108.858911410754, 14111.788323174955, 14112.223827689575, 14113.2943352834, 22022.779772202073, 22383.104675812785, 22388.21641242549, 22484.550308993403, 22554.548909022054, 17525.824741752418, 17764.46706598804, 17835.286588536314, 17887.552811179823, 17903.0, 15767.763483547527, 16065.27706253198, 16255.837441625905, 16389.34442622282, 16478.75281870749, 18507.259709612004, 18685.15916783775, 18688.439346819618, 18719.157637906053, 18918.243270269584, 13677.31613419345, 14309.499167529086, 14497.637559061108, 14508.492202773274, 14539.34572944199, 18281.3601523946, 18506.352277670216, 18520.722189166903, 18550.721739174194, 18589.721154182967], "value": 11958.410434393876, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1341.483528841396, 1383.6748364134432, 1383.6886700492387, 1386.5978866128817, 1389.7915312703094, 14649.560513184608, 15290.235488225586, 15347.923260383683, 15358.078515289077, 15662.216889155554, 15534.37862485502, 15772.76340854888, 15851.920740396281, 15853.20733963303, 15856.28646710898, 2724.1827451764443, 2793.5809628555676, 2820.915372538817, 2821.2241633550834, 2872.5116730155924, 2788.776897848167, 2803.9719602804016, 2814.9718502814912, 2816.2818481287245, 2818.3940452802644, 2786.192004318755, 2834.3622684895836, 2835.517961946474, 2835.7589604883506, 2835.957460638092, 2721.2788611018095, 2734.343757498206, 2735.8084934054623, 2741.3420779013095, 2744.533429317021, 2684.704682484925, 2706.986465067682, 2707.0254708304997, 2707.323169207698, 2709.0924540278834, 14847.70304593902, 14967.176805275705, 15192.088474691554, 15307.693846123015, 15319.31063102163, 7773.7667869963425, 8140.3487720982175, 8142.063662678808, 8142.145074767123, 8142.51144931306, 5379.5427388671615, 5633.239512665778, 5751.194832723422, 5802.7388767505145, 5806.506446952014, 1895.3934740882924, 1922.951926201842, 1924.595834874678, 1972.1815446589649, 1989.1744925855753, 26690.06584769543, 26913.32716682079, 26978.865105674544, 27051.458970820473, 27189.456210875673, 6794.694238759268, 6820.386165245052, 6909.723611055602, 6949.548279361826, 7027.15674119109, 17131.486055418358, 17255.56861078458, 17270.13649317529, 17289.394871179447, 17294.913525432294, 7609.6575654095695, 7709.653065612061, 7715.267049630276, 7716.228377162239, 7721.305082542486, 5906.8818623627285, 6000.879982400327, 6292.559520833589, 6295.0, 7468.775936721907, 5246.344206974129, 5379.838604841861, 5380.085385484477, 5469.511372325583, 5609.5792815539, 1559.0723519505875, 1575.6060984753813, 1575.8975666581864, 1589.8887077904435, 1609.7102521546, 895.7939673875045, 912.8950170730318, 916.5417291354323, 916.7983043730369, 928.0580211085753, 7586.772396828104, 7691.961540192263, 7721.459497835098, 7792.298693117533, 7817.960910195413, 712.9857402851914, 718.1238888555953, 726.57132291948, 729.9160596531467, 740.4779630360583, 4544.977275113603, 4551.3173024046655, 4714.127886340969, 4990.426100998432, 5195.376554813447, 20647.690284645443, 22283.777162228493, 22489.32532024042, 22490.100395983976, 22491.66262506064, 21289.722616643052, 21496.785032149477, 22005.0, 22170.334889953327, 22182.445438863833, 11300.265482743594, 11636.534538618529, 11735.354555499358, 11764.470598823074, 11778.52885884555, 8547.61535730906, 8816.735497935073, 8891.955540222258, 9090.500022498825, 9158.633654653739, 18656.813431865507, 19092.04539772978, 19228.23087076501, 19487.70768438503, 19709.704354434984, 19097.331593394163, 19336.903315483334, 19468.0, 19543.511412214808, 19849.503762406057, 12112.515499380279, 12258.938705306417, 12379.381030948236, 12388.070894683115, 12388.938055309665, 14153.292335383396, 14223.217723025333, 14257.00200985921, 14261.572152835432, 14263.42946282137, 11377.54489820431, 11420.885791141982, 11428.542858285908, 11520.193586449202, 11752.764944700886, 10953.890461095605, 11204.719882003015, 11347.829782553434, 11481.311121332747, 11499.08007359426, 10378.273520853469, 10589.4705264738, 10601.098906593026, 10602.46987650599, 10607.363558186533, 7249.347558719741, 7269.636518174176, 7282.635868206675, 7300.525465844703, 7304.086989126359, 7485.5508669480005, 7504.962475187589, 7547.358474529727, 7566.508176968479, 7587.734429294948], "value": 6717.997655852178, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [507.59680351202115, 520.2040877457491, 521.1583292981834, 531.5295963072682, 533.194875737636, 6472.0, 6487.935120648792, 6491.221053473578, 6512.413882750551, 6563.015547667852, 6249.750009999594, 6404.199475065617, 6414.839629009277, 6459.580127291722, 6473.9930621507365, 5288.788448462057, 5289.8626795238915, 5297.682139071649, 5303.045451818671, 5339.8252384475545, 4907.723991762132, 5208.531232189102, 5233.581313494911, 5259.684418934857, 5336.866578335534, 4925.3350797642215, 5024.598032157419, 5032.521910418523, 5069.163588007993, 5076.40093370589, 5015.924761128549, 5046.9747651261505, 5103.5151660592555, 5113.974430127862, 5121.795128194868, 4515.954840451586, 4533.750643714594, 4542.636589072867, 4575.176468235716, 4587.518310577408, 6273.404026617464, 6276.592021518587, 6291.6854157291955, 6326.272478664966, 6388.55280130391, 5797.217375654275, 5811.738471768738, 5820.35976042635, 5859.619124756877, 5868.735906884201, 6657.167854018247, 6686.465082793365, 6710.899336509956, 6738.4609231261875, 6745.12313399255, 4915.287283343895, 4947.158982972867, 4947.678400903929, 4969.950300496985, 4982.352294201767, 6767.932320676779, 6929.272426395206, 6941.305869413069, 6974.163100427931, 7004.334588214111, 4944.728039957837, 4949.48030456804, 4960.652754307236, 4967.975160124249, 5004.799808007639, 5010.824621138243, 5012.1980483122525, 5041.495850415003, 5061.468545802712, 5078.873028174251, 5655.208270842003, 5665.688387138747, 5687.289088863892, 5724.599278050579, 5762.567807414377, 6716.1604799400075, 6723.596584204964, 6732.326767323327, 6751.763688270887, 6782.0, 1754.9996501993996, 1772.5923037701143, 1781.6792977263958, 1785.5625371783997, 1803.449947765944, 1167.5971789732528, 1226.920250183735, 1233.3894722112611, 1243.9378031098408, 1244.0793812578627, 5833.270841144857, 5833.970830145822, 5854.2389489366105, 5955.702214889238, 5957.41279215002, 6668.499862510234, 6700.463962882957, 6855.012046506457, 6877.793666189922, 6882.518223724292, 5846.41535846412, 5883.205767221456, 5902.61632993854, 5959.642421454727, 6030.306514750772, 3610.2851145706104, 3620.7827530348263, 3635.690966267897, 3636.7089683162626, 3685.2261025184475, 6507.511936604774, 6611.66941652925, 6637.834054148589, 6690.866182676319, 6725.63009034498, 6992.0, 7017.333353331425, 7033.9296607033275, 7112.857742845114, 7133.179684336368, 6601.207855057424, 6611.73553057882, 6612.570182937998, 6671.799846004627, 6796.111652547746, 6797.422219111431, 6858.897116543156, 6933.687984040629, 6937.7571784987285, 6977.755778547727, 6617.66911654425, 6741.4382534636525, 6762.289959554176, 6770.593764374154, 6869.656517174021, 6627.1716035495565, 6631.568948018364, 6687.230968438692, 6694.966525167343, 6717.932820671731, 5546.7781288748, 5614.606977511535, 5636.774529018793, 5664.915026274692, 5680.2615659965595, 6680.231773346128, 6789.978459585437, 6807.21717002551, 6905.585664860125, 7015.438764898694, 6528.836779080561, 6573.079768832463, 6712.160979877515, 6758.189017317954, 6771.796846094625, 6735.114168032958, 6743.2582415935185, 6754.223264324665, 6765.391114799691, 6765.458763299022, 6617.8014659560295, 6635.606522630302, 6651.800445986628, 6658.43403310724, 6662.766803161866, 6642.269350371552, 6688.0, 6730.932690673227, 6743.291954344723, 6798.694058767466, 6406.23125224976, 6457.935420645734, 6535.183102112236, 6537.313582073813, 6541.528156164824], "value": 5179.921771618702, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [888.8711136885148, 907.7140700679287, 921.5208091792268, 925.1765928323794, 939.7744541310085, 19015.334463293788, 20030.69953950692, 20062.398128056164, 20207.898960505176, 20214.191432342726, 18504.444866654023, 18739.0, 18984.050797460142, 19008.429747107573, 19095.61808763824, 940.0646356874919, 945.678469320431, 946.0870260198907, 948.8102379524123, 951.1962391778935, 954.7756277274835, 966.2077096780642, 974.468914441631, 974.5273542331963, 976.3019441099613, 1008.9445080520568, 1011.7672935224903, 1017.9338343007718, 1019.1846522781782, 1020.7907378987289, 986.0632399220698, 1004.8894621591692, 1011.2617789014024, 1020.214434885138, 1020.7907378987289, 734.1740541890373, 739.8187444076182, 743.2567432567432, 743.5204293230836, 743.6393349225622, 19898.303559375352, 20069.0, 20104.29634962784, 20194.596108077756, 20195.394138175878, 20857.0, 22162.66755998645, 22184.556308873893, 22199.11307538861, 22343.55312893733, 17484.03837788921, 17652.91173544124, 17684.469465915914, 17749.556261093578, 17817.910910445495, 3661.304352173105, 3686.5760437549757, 3686.8156592170553, 3691.187938653492, 3696.685781708558, 138614.30692846572, 139770.0, 140582.29708851493, 140664.0, 141786.0, 16434.342626294816, 16963.406280780113, 16995.150242487827, 16999.49001529956, 17041.0, 29156.0, 29231.707682923323, 29862.0, 29937.251568710522, 30224.546631800542, 8350.874736878952, 8405.495670259805, 8418.705345312885, 8420.115887831813, 8423.4945903246, 3816.427535869642, 3834.9424758628643, 3877.379619260961, 3895.435161901565, 3905.3946638271113, 5014.348134742533, 5099.082165210298, 5102.464241254689, 5115.053715062651, 5116.3348764661105, 902.4179404284331, 922.7693076730817, 938.1650331205096, 940.1867384712311, 940.4216406909838, 689.2487188964053, 702.104816359136, 713.370227225304, 715.8174665460274, 720.3732752505249, 11737.530498779954, 12241.20432171906, 12302.446389912297, 12494.562690305978, 12708.159918655083, 632.6299115017766, 632.6583644831832, 638.7923924724483, 643.9066335381343, 651.2835880531472, 5761.423857614205, 5804.65172089676, 5885.970570147122, 5898.64608123514, 6014.849628759316, 122571.38714306371, 123862.0, 124132.37933810274, 124231.65961523248, 126938.36530817472, 104628.0, 104876.0, 110330.0, 111457.0, 115197.24013799276, 94133.0, 95068.0, 95743.52128239314, 97094.14529273649, 98129.50935245278, 12607.43266552989, 12693.174943628635, 13356.265405402795, 13545.1195672281, 13653.0, 42712.35931461093, 43162.13675726405, 45033.0, 45047.549524504335, 45215.77392113018, 76094.61952690422, 78467.0, 81357.0, 81841.59079204565, 82340.17659823564, 18675.252989880253, 18909.71635425497, 19130.23479060822, 19135.521611959255, 19520.707189391887, 21220.787792121882, 22097.005634746154, 22381.32856014322, 22428.0, 22867.19964801224, 19464.416067517996, 19719.112639931525, 20088.79911200869, 20121.195152194334, 20182.0, 19384.0, 19620.0, 19922.800771992675, 20158.29445969384, 20354.0, 18148.364807231683, 18282.817171828643, 18409.53976150607, 18504.259829607203, 18994.335198267996, 11816.70458238551, 12057.758844823229, 12089.69775755578, 12398.318092504998, 12688.746225075261, 13731.382087805872, 14011.789823152458, 14091.718165636425, 14361.0, 14481.983669188872], "value": 9321.89324152819, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1434.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 108.0, 107.0, 106.0, 108.0, 96.0, 108.0, 110.0, 108.0, 109.0], "value": 106.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 120.0, 116.0, 119.0, 116.0, 123.0, 141.0, 133.0, 128.0, 121.0], "value": 123.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 164.0, 163.0, 164.0, 162.0, 164.0, 171.0, 165.0, 162.0], "value": 164.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 73.0, 73.0, 74.0, 74.0, 77.0, 77.0, 76.0, 75.0], "value": 74.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 86.0, 86.0, 79.0, 78.0, 79.0, 80.0, 85.0, 79.0], "value": 81.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 114.0, 114.0, 114.0, 114.0, 113.0, 117.0, 114.0, 119.0], "value": 114.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 148.0, 147.0, 147.0, 147.0, 149.0, 147.0, 151.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 99.0, 98.0, 94.0, 93.0, 95.0, 94.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 56.0, 51.0, 57.0, 52.0, 52.0, 59.0, 51.0, 52.0, 51.0], "value": 53.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [39.0, 38.0, 38.0, 37.0, 37.0, 39.0, 38.0, 38.0, 38.0, 38.0], "value": 38.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 74.0, 77.0, 74.0, 77.0, 75.0, 74.0, 75.0], "value": 75.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 125.0, 124.0, 117.0, 115.0, 130.0, 118.0, 115.0, 129.0, 126.0], "value": 121.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 170.0, 180.0, 170.0, 172.0, 176.0, 176.0, 169.0, 176.0, 170.0], "value": 173.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 65.0, 64.0, 66.0, 63.0, 63.0, 68.0, 68.0], "value": 65.0, "unit": "score"}]}]} 11:19:04 INFO - Return code: 0 11:19:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:19:04 INFO - # TBPL SUCCESS # 11:19:04 INFO - Running post-action listener: _package_coverage_data 11:19:04 INFO - Running post-action listener: _resource_record_post_action 11:19:04 INFO - [mozharness: 2017-09-07 18:19:04.969907Z] Finished run-tests step (success) 11:19:04 INFO - Running post-run listener: _resource_record_post_run 11:19:05 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 8192; Write bytes: 391827456; Read time: 16; Write time: 240196 11:19:05 INFO - TinderboxPrint: CPU usage
13.1% 11:19:05 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 16 11:19:05 INFO - TinderboxPrint: I/O write bytes / time
391,827,456 / 240,196 11:19:05 INFO - TinderboxPrint: CPU idle
8,222.5 (86.9%) 11:19:05 INFO - TinderboxPrint: CPU user
1,192.5 (12.6%) 11:19:05 INFO - TinderboxPrint: Swap in / out
0 / 0 11:19:05 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 106389504; Read time: 0; Write time: 81500 11:19:05 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:19:05 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 8192; Write bytes: 285020160; Read time: 16; Write time: 158672 11:19:05 INFO - Running post-run listener: _upload_blobber_files 11:19:05 INFO - Blob upload gear active. 11:19:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:19:05 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:19:05 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:19:05 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:19:06 INFO - (blobuploader) - INFO - Open directory for files ... 11:19:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:19:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:19:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:19:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:19:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:19:07 INFO - (blobuploader) - INFO - Done attempting. 11:19:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:19:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:19:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:19:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:19:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:19:12 INFO - (blobuploader) - INFO - Done attempting. 11:19:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:19:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:19:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:19:14 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:19:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:19:14 INFO - (blobuploader) - INFO - Done attempting. 11:19:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:19:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:19:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:19:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:19:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:19:16 INFO - (blobuploader) - INFO - Done attempting. 11:19:16 INFO - (blobuploader) - INFO - Iteration through files over. 11:19:16 INFO - Return code: 0 11:19:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:19:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:19:16 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9f950940204921a178b10efb03a31eace817bdde39a8fa9de32f0f2b324d26a76f7006231e4f040fe9be7ca4a8d94c072ff701ffc72d9b9b43a2831208fac8d2", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/941e3ecbb6e7736303077d2a6a6738aeacde5df3514e01e9dfd74df89edcb4da206205b0fce2d2ffa2c927283b1690744beb410e15b97871ba723a012acf23f6", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/14a2bda53c404f7c35c275b720b74d9207682844eecf586da268a37efc7a5e46468f8486ddb7f94f3db96cc34cbd8c05a496ca12b932883387c665bd1ff3ccdb", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e7568fefe20c49363918a3a208a42a11c5ee9eb5c3cd384e6cab43dcc3a8a2ba19cc94c8b2b2e2a3ba7ae2fc110ab0187f8ae61e7d388c31555d05c5c730d18d"} 11:19:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:19:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:19:16 INFO - Contents: 11:19:16 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9f950940204921a178b10efb03a31eace817bdde39a8fa9de32f0f2b324d26a76f7006231e4f040fe9be7ca4a8d94c072ff701ffc72d9b9b43a2831208fac8d2", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/941e3ecbb6e7736303077d2a6a6738aeacde5df3514e01e9dfd74df89edcb4da206205b0fce2d2ffa2c927283b1690744beb410e15b97871ba723a012acf23f6", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/14a2bda53c404f7c35c275b720b74d9207682844eecf586da268a37efc7a5e46468f8486ddb7f94f3db96cc34cbd8c05a496ca12b932883387c665bd1ff3ccdb", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e7568fefe20c49363918a3a208a42a11c5ee9eb5c3cd384e6cab43dcc3a8a2ba19cc94c8b2b2e2a3ba7ae2fc110ab0187f8ae61e7d388c31555d05c5c730d18d"} 11:19:16 INFO - Running post-run listener: copy_logs_to_upload_dir 11:19:16 INFO - Copying logs to upload dir... 11:19:16 INFO - mkdir: /builds/slave/test/build/upload/logs 11:19:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.334485 ========= master_lag: 0.12 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-09-07 11:19:16.247197) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-07 11:19:16.251653) ========= 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=923d835db2ba3686ebe126b700000192-1504807105.814051-1321574702 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9f950940204921a178b10efb03a31eace817bdde39a8fa9de32f0f2b324d26a76f7006231e4f040fe9be7ca4a8d94c072ff701ffc72d9b9b43a2831208fac8d2", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/941e3ecbb6e7736303077d2a6a6738aeacde5df3514e01e9dfd74df89edcb4da206205b0fce2d2ffa2c927283b1690744beb410e15b97871ba723a012acf23f6", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/14a2bda53c404f7c35c275b720b74d9207682844eecf586da268a37efc7a5e46468f8486ddb7f94f3db96cc34cbd8c05a496ca12b932883387c665bd1ff3ccdb", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e7568fefe20c49363918a3a208a42a11c5ee9eb5c3cd384e6cab43dcc3a8a2ba19cc94c8b2b2e2a3ba7ae2fc110ab0187f8ae61e7d388c31555d05c5c730d18d"} build_url:https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011483 build_url: 'https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9f950940204921a178b10efb03a31eace817bdde39a8fa9de32f0f2b324d26a76f7006231e4f040fe9be7ca4a8d94c072ff701ffc72d9b9b43a2831208fac8d2", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/941e3ecbb6e7736303077d2a6a6738aeacde5df3514e01e9dfd74df89edcb4da206205b0fce2d2ffa2c927283b1690744beb410e15b97871ba723a012acf23f6", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/14a2bda53c404f7c35c275b720b74d9207682844eecf586da268a37efc7a5e46468f8486ddb7f94f3db96cc34cbd8c05a496ca12b932883387c665bd1ff3ccdb", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e7568fefe20c49363918a3a208a42a11c5ee9eb5c3cd384e6cab43dcc3a8a2ba19cc94c8b2b2e2a3ba7ae2fc110ab0187f8ae61e7d388c31555d05c5c730d18d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-07 11:19:16.282621) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 11:19:16.282928) ========= 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=923d835db2ba3686ebe126b700000192-1504807105.814051-1321574702 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004619 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 11:19:16.363100) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-07 11:19:16.366463) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-07 11:19:16.366790) ========= ========= Total master_lag: 0.29 =========