builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-079 starttime: 1502931021.07 results: success (0) revision: 63ca686c3f1e870649b6d9c559973d100573aec2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-16 17:50:21.069872) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-16 17:50:21.070350) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-16 17:50:21.070667) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-16 17:50:21.121411) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 17:50:21.121715) ========= 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=1258088b6da462a47ba2cd90000001a2-1502921563.454632-356199533 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-16 17:50:21-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 101M=0s 2017-08-16 17:50:21 (101 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.130990 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 17:50:21.269558) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 17:50:21.269954) ========= 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=1258088b6da462a47ba2cd90000001a2-1502921563.454632-356199533 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014950 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 17:50:21.320566) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-16 17:50:21.320932) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 63ca686c3f1e870649b6d9c559973d100573aec2 --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 63ca686c3f1e870649b6d9c559973d100573aec2 --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=1258088b6da462a47ba2cd90000001a2-1502921563.454632-356199533 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-16 17:50:21,556 truncating revision to first 12 chars 2017-08-16 17:50:21,556 Setting DEBUG logging. 2017-08-16 17:50:21,556 attempt 1/10 2017-08-16 17:50:21,556 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/63ca686c3f1e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-16 17:50:22,171 unpacking tar archive at: mozilla-central-63ca686c3f1e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.995466 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-16 17:50:22.333953) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-16 17:50:22.334261) ========= script_repo_revision: 63ca686c3f1e870649b6d9c559973d100573aec2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-16 17:50:22.334675) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-16 17:50:22.334976) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-16 17:50:22.364520) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-08-16 17:50:22.364840) ========= /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=1258088b6da462a47ba2cd90000001a2-1502921563.454632-356199533 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:50:22 INFO - MultiFileLogger online at 20170816 17:50:22 in /builds/slave/test 17:50:22 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 17:50:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:50:22 INFO - {'append_to_log': False, 17:50:22 INFO - 'base_work_dir': '/builds/slave/test', 17:50:22 INFO - 'blob_upload_branch': 'Firefox', 17:50:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:50:22 INFO - 'branch': 'Firefox', 17:50:22 INFO - 'buildbot_json_path': 'buildprops.json', 17:50:22 INFO - 'code_coverage': False, 17:50:22 INFO - 'config_files': ('talos/linux_config.py',), 17:50:22 INFO - 'default_actions': ('clobber', 17:50:22 INFO - 'read-buildbot-config', 17:50:22 INFO - 'download-and-extract', 17:50:22 INFO - 'populate-webroot', 17:50:22 INFO - 'create-virtualenv', 17:50:22 INFO - 'install', 17:50:22 INFO - 'setup-mitmproxy', 17:50:22 INFO - 'run-tests'), 17:50:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:50:22 INFO - 'disable_ccov_upload': False, 17:50:22 INFO - 'download_minidump_stackwalk': True, 17:50:22 INFO - 'download_symbols': 'ondemand', 17:50:22 INFO - 'enable_stylo': False, 17:50:22 INFO - 'enable_webrender': False, 17:50:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:50:22 INFO - 'tooltool.py': '/tools/tooltool.py', 17:50:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:50:22 INFO - '/tools/misc-python/virtualenv.py')}, 17:50:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:50:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:50:22 INFO - 'gecko_profile': False, 17:50:22 INFO - 'gecko_profile_interval': 0, 17:50:22 INFO - 'installer_path': 'installer.exe', 17:50:22 INFO - 'log_level': 'info', 17:50:22 INFO - 'log_name': 'talos', 17:50:22 INFO - 'log_to_console': True, 17:50:22 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:50:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:50:22 INFO - 'opt_config_files': (), 17:50:22 INFO - 'pip_index': False, 17:50:22 INFO - 'suite': 'dromaeojs-e10s', 17:50:22 INFO - 'system_bits': '32', 17:50:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:50:22 INFO - 'title': 'talos-linux64-ix-079', 17:50:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:50:22 INFO - 'use_talos_json': True, 17:50:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:50:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:50:22 INFO - 'work_dir': 'build'} 17:50:22 INFO - [mozharness: 2017-08-17 00:50:22.702710Z] Running clobber step. 17:50:22 INFO - Running pre-action listener: _resource_record_pre_action 17:50:22 INFO - Running main action method: clobber 17:50:22 INFO - rmtree: /builds/slave/test/build 17:50:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:50:23 INFO - Running post-action listener: _resource_record_post_action 17:50:23 INFO - [mozharness: 2017-08-17 00:50:23.712878Z] Finished clobber step (success) 17:50:23 INFO - [mozharness: 2017-08-17 00:50:23.712980Z] Running read-buildbot-config step. 17:50:23 INFO - Running pre-action listener: _resource_record_pre_action 17:50:23 INFO - Running main action method: read_buildbot_config 17:50:23 INFO - Using buildbot properties: 17:50:23 INFO - { 17:50:23 INFO - "project": "", 17:50:23 INFO - "product": "firefox", 17:50:23 INFO - "who": "kwierso@gmail.com", 17:50:23 INFO - "installer_path": "public/build/target.tar.bz2", 17:50:23 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 17:50:23 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 17:50:23 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 17:50:23 INFO - "stage_platform": "linux64-stylosequential", 17:50:23 INFO - "basedir": "/builds/slave/test", 17:50:23 INFO - "buildnumber": 193, 17:50:23 INFO - "platform": "ubuntu64_hw_styloseq", 17:50:23 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:50:23 INFO - "slavebuilddir": "test", 17:50:23 INFO - "taskId": "SXq-JnC2Tv6RVj9zy1fL-A", 17:50:23 INFO - "branch": "mozilla-central", 17:50:23 INFO - "script_repo_revision": "production", 17:50:23 INFO - "revision": "63ca686c3f1e870649b6d9c559973d100573aec2", 17:50:23 INFO - "slavename": "talos-linux64-ix-079", 17:50:23 INFO - "repo_path": "mozilla-central" 17:50:23 INFO - } 17:50:23 INFO - Finding installer, test and symbols from parent task. 17:50:23 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SXq-JnC2Tv6RVj9zy1fL-A'}, attempt #1 17:50:24 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SXq-JnC2Tv6RVj9zy1fL-A'}, attempt #1 17:50:24 INFO - Task dependencies: VGVatiFiSBqe2fkjUp-Rdg 17:50:24 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VGVatiFiSBqe2fkjUp-Rdg'}, attempt #1 17:50:25 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/VGVatiFiSBqe2fkjUp-Rdg/artifacts/public/build/target.tar.bz2 17:50:25 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/VGVatiFiSBqe2fkjUp-Rdg/artifacts/public/build/target.test_packages.json 17:50:25 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/VGVatiFiSBqe2fkjUp-Rdg/artifacts/public/build/target.crashreporter-symbols.zip 17:50:25 INFO - Running post-action listener: _resource_record_post_action 17:50:25 INFO - [mozharness: 2017-08-17 00:50:25.055580Z] Finished read-buildbot-config step (success) 17:50:25 INFO - [mozharness: 2017-08-17 00:50:25.055803Z] Running download-and-extract step. 17:50:25 INFO - Running pre-action listener: _resource_record_pre_action 17:50:25 INFO - Running main action method: download_and_extract 17:50:25 INFO - mkdir: /builds/slave/test/build/tests 17:50:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:50:25 INFO - trying https://queue.taskcluster.net/v1/task/VGVatiFiSBqe2fkjUp-Rdg/artifacts/public/build/target.test_packages.json 17:50:25 INFO - Downloading https://queue.taskcluster.net/v1/task/VGVatiFiSBqe2fkjUp-Rdg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 17:50:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VGVatiFiSBqe2fkjUp-Rdg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 17:50:25 INFO - Downloaded 989 bytes. 17:50:25 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 17:50:25 INFO - Using the following test package requirements: 17:50:25 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 17:50:25 INFO - u'common': [u'target.common.tests.zip'], 17:50:25 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 17:50:25 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 17:50:25 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 17:50:25 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 17:50:25 INFO - u'mozbase': [u'target.common.tests.zip'], 17:50:25 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 17:50:25 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 17:50:25 INFO - u'web-platform': [u'target.common.tests.zip', 17:50:25 INFO - u'target.web-platform.tests.tar.gz'], 17:50:25 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 17:50:25 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 17:50:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VGVatiFiSBqe2fkjUp-Rdg/artifacts/public/build/target.common.tests.zip 17:50:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VGVatiFiSBqe2fkjUp-Rdg/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:50:25 INFO - Fetch https://queue.taskcluster.net/v1/task/VGVatiFiSBqe2fkjUp-Rdg/artifacts/public/build/target.common.tests.zip into memory 17:50:27 INFO - Content-Length response header: 53999262 17:50:27 INFO - Bytes received: 53999262 17:50:38 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 17:50:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VGVatiFiSBqe2fkjUp-Rdg/artifacts/public/build/target.common.tests.zip 17:50:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VGVatiFiSBqe2fkjUp-Rdg/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:50:38 INFO - Fetch https://queue.taskcluster.net/v1/task/VGVatiFiSBqe2fkjUp-Rdg/artifacts/public/build/target.common.tests.zip into memory 17:50:39 INFO - Content-Length response header: 53999262 17:50:39 INFO - Bytes received: 53999262 17:50:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VGVatiFiSBqe2fkjUp-Rdg/artifacts/public/build/target.talos.tests.zip 17:50:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VGVatiFiSBqe2fkjUp-Rdg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 17:50:51 INFO - Fetch https://queue.taskcluster.net/v1/task/VGVatiFiSBqe2fkjUp-Rdg/artifacts/public/build/target.talos.tests.zip into memory 17:50:51 INFO - Content-Length response header: 14496161 17:50:51 INFO - Bytes received: 14496161 17:50:52 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')]} 17:50:52 INFO - trying https://queue.taskcluster.net/v1/task/VGVatiFiSBqe2fkjUp-Rdg/artifacts/public/build/target.tar.bz2 17:50:52 INFO - Downloading https://queue.taskcluster.net/v1/task/VGVatiFiSBqe2fkjUp-Rdg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 17:50:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VGVatiFiSBqe2fkjUp-Rdg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 17:50:53 INFO - Downloaded 61844620 bytes. 17:50:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VGVatiFiSBqe2fkjUp-Rdg/artifacts/public/build/target.tar.bz2 17:50:53 INFO - mkdir: /builds/slave/test/properties 17:50:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:50:53 INFO - Writing to file /builds/slave/test/properties/build_url 17:50:53 INFO - Contents: 17:50:53 INFO - build_url:https://queue.taskcluster.net/v1/task/VGVatiFiSBqe2fkjUp-Rdg/artifacts/public/build/target.tar.bz2 17:50:53 INFO - Running post-action listener: _resource_record_post_action 17:50:53 INFO - Running post-action listener: set_extra_try_arguments 17:50:53 INFO - [mozharness: 2017-08-17 00:50:53.337762Z] Finished download-and-extract step (success) 17:50:53 INFO - [mozharness: 2017-08-17 00:50:53.337861Z] Running populate-webroot step. 17:50:53 INFO - Running pre-action listener: _resource_record_pre_action 17:50:53 INFO - Running main action method: populate_webroot 17:50:53 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:50:53 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 17:50:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:50:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:50:53 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 17:50:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:50:53 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:50:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:50:53 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:50:53 INFO - 'talos_options': ['--stylo'], 17:50:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:50:53 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:50:53 INFO - 'tests': ['damp', 'tps']}, 17:50:53 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:50:53 INFO - 'talos_options': ['--stylo'], 17:50:53 INFO - 'tests': ['damp', 'tps']}, 17:50:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:50:53 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 17:50:53 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 17:50:53 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 17:50:53 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 17:50:53 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 17:50:53 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:50:53 INFO - 'talos_options': ['--stylo'], 17:50:53 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 17:50:53 INFO - 'other-e10s': {'tests': ['a11yr', 17:50:53 INFO - 'ts_paint', 17:50:53 INFO - 'tpaint', 17:50:53 INFO - 'sessionrestore', 17:50:53 INFO - 'sessionrestore_many_windows', 17:50:53 INFO - 'sessionrestore_no_auto_restore', 17:50:53 INFO - 'tabpaint']}, 17:50:53 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 17:50:53 INFO - 'tests': ['a11yr', 17:50:53 INFO - 'ts_paint', 17:50:53 INFO - 'tpaint', 17:50:53 INFO - 'sessionrestore', 17:50:53 INFO - 'sessionrestore_many_windows', 17:50:53 INFO - 'sessionrestore_no_auto_restore', 17:50:53 INFO - 'tabpaint']}, 17:50:53 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 17:50:53 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 17:50:53 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 17:50:53 INFO - 'tests': ['bloom_basic_singleton']}, 17:50:53 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 17:50:53 INFO - 'tests': ['bloom_basic']}, 17:50:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:50:53 INFO - 'tsvgr_opacity', 17:50:53 INFO - 'tart', 17:50:53 INFO - 'tscrollx', 17:50:53 INFO - 'tsvg_static']}, 17:50:53 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 17:50:53 INFO - 'tests': ['tsvgx', 17:50:53 INFO - 'tsvgr_opacity', 17:50:53 INFO - 'tart', 17:50:53 INFO - 'tscrollx', 17:50:53 INFO - 'tsvg_static']}, 17:50:53 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:50:53 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:50:53 INFO - 'talos_options': ['--stylo'], 17:50:53 INFO - 'tests': ['tp5o']}, 17:50:53 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:50:53 INFO - 'talos_options': ['--mitmproxy', 17:50:53 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:50:53 INFO - '--firstNonBlankPaint'], 17:50:53 INFO - 'tests': ['tp6_google', 17:50:53 INFO - 'tp6_youtube', 17:50:53 INFO - 'tp6_amazon', 17:50:53 INFO - 'tp6_facebook']}, 17:50:53 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:50:53 INFO - 'talos_options': ['--stylo', 17:50:53 INFO - '--mitmproxy', 17:50:53 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:50:53 INFO - '--firstNonBlankPaint'], 17:50:53 INFO - 'tests': ['tp6_google', 17:50:53 INFO - 'tp6_youtube', 17:50:53 INFO - 'tp6_amazon', 17:50:53 INFO - 'tp6_facebook']}, 17:50:53 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:50:53 INFO - 'talos_options': ['--stylo', 17:50:53 INFO - '--stylo-threads=1', 17:50:53 INFO - '--mitmproxy', 17:50:53 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:50:53 INFO - '--firstNonBlankPaint'], 17:50:53 INFO - 'tests': ['tp6_google', 17:50:53 INFO - 'tp6_youtube', 17:50:53 INFO - 'tp6_amazon', 17:50:53 INFO - 'tp6_facebook']}, 17:50:53 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:50:53 INFO - 'talos_options': ['--xperf_path', 17:50:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:50:53 INFO - 'tests': ['tp5n']}, 17:50:53 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:50:53 INFO - 'talos_options': ['--stylo', 17:50:53 INFO - '--xperf_path', 17:50:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:50:53 INFO - 'tests': ['tp5n']}}} 17:50:53 INFO - Running post-action listener: _resource_record_post_action 17:50:53 INFO - [mozharness: 2017-08-17 00:50:53.352226Z] Finished populate-webroot step (success) 17:50:53 INFO - [mozharness: 2017-08-17 00:50:53.352317Z] Running create-virtualenv step. 17:50:53 INFO - Running pre-action listener: _resource_record_pre_action 17:50:53 INFO - Running main action method: create_virtualenv 17:50:53 INFO - Creating virtualenv /builds/slave/test/build/venv 17:50:53 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:50:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:50:53 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 17:50:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:50:53 INFO - Using real prefix '/usr' 17:50:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:50:53 INFO - Installing distribute.............................................................................................................................................................................................done. 17:50:55 INFO - Installing pip.................done. 17:50:55 INFO - Return code: 0 17:50:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:50:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:50:56 INFO - Reading from file tmpfile_stdout 17:50:56 INFO - Output received: 17:50:56 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 17:50:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:50:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:50:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:50:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:50:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:50:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0xc641f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd68a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf0bef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf090b0>, '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 0xf09fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf0a440>, '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': '1258088b6da462a47ba2cd90000001a2-1502921563.454632-356199533', '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 17:50:56 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 17:50:56 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 17:50:56 INFO - Using env: {'DISPLAY': ':0', 17:50:56 INFO - 'HOME': '/home/cltbld', 17:50:56 INFO - 'LANG': 'en_US.UTF-8', 17:50:56 INFO - 'LANGUAGE': 'en_US:en', 17:50:56 INFO - 'LOGNAME': 'cltbld', 17:50:56 INFO - 'MAIL': '/var/mail/cltbld', 17:50:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:50:56 INFO - 'MOZ_NO_REMOTE': '1', 17:50:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:50:56 INFO - 'NO_EM_RESTART': '1', 17:50:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:50:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:50:56 INFO - 'PWD': '/builds/slave/test', 17:50:56 INFO - 'SHELL': '/bin/bash', 17:50:56 INFO - 'SHLVL': '1', 17:50:56 INFO - 'TERM': 'linux', 17:50:56 INFO - 'TMOUT': '86400', 17:50:56 INFO - 'USER': 'cltbld', 17:50:56 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1502921563.454632-356199533', 17:50:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:50:56 INFO - '_': '/tools/buildbot/bin/python'} 17:50:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:50:56 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 17:50:56 INFO - Cleaning up... 17:50:56 INFO - Return code: 0 17:50:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:50:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:50:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:50:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:50:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:50:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0xc641f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd68a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf0bef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf090b0>, '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 0xf09fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf0a440>, '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': '1258088b6da462a47ba2cd90000001a2-1502921563.454632-356199533', '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 17:50:56 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 17:50:56 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 17:50:56 INFO - Using env: {'DISPLAY': ':0', 17:50:56 INFO - 'HOME': '/home/cltbld', 17:50:56 INFO - 'LANG': 'en_US.UTF-8', 17:50:56 INFO - 'LANGUAGE': 'en_US:en', 17:50:56 INFO - 'LOGNAME': 'cltbld', 17:50:56 INFO - 'MAIL': '/var/mail/cltbld', 17:50:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:50:56 INFO - 'MOZ_NO_REMOTE': '1', 17:50:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:50:56 INFO - 'NO_EM_RESTART': '1', 17:50:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:50:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:50:56 INFO - 'PWD': '/builds/slave/test', 17:50:56 INFO - 'SHELL': '/bin/bash', 17:50:56 INFO - 'SHLVL': '1', 17:50:56 INFO - 'TERM': 'linux', 17:50:56 INFO - 'TMOUT': '86400', 17:50:56 INFO - 'USER': 'cltbld', 17:50:56 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1502921563.454632-356199533', 17:50:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:50:56 INFO - '_': '/tools/buildbot/bin/python'} 17:50:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:50:56 INFO - Downloading/unpacking psutil>=3.1.1 17:50:56 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 17:50:56 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 17:50:56 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 17:50:56 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 17:50:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:50:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:50:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:50:57 INFO - Installing collected packages: psutil 17:50:57 INFO - Running setup.py install for psutil 17:50:57 INFO - building 'psutil._psutil_linux' extension 17:50:57 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 17:50:57 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 17:50:58 INFO - building 'psutil._psutil_posix' extension 17:50:58 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 17:50:58 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 17:50:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:50:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:50:58 INFO - Successfully installed psutil 17:50:58 INFO - Cleaning up... 17:50:58 INFO - Return code: 0 17:50:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:50:58 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')]} 17:50:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:50:58 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')]} 17:50:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:50:58 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 0xc641f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd68a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf0bef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf090b0>, '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 0xf09fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf0a440>, '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': '1258088b6da462a47ba2cd90000001a2-1502921563.454632-356199533', '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 17:50:58 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 17:50:58 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 17:50:58 INFO - Using env: {'DISPLAY': ':0', 17:50:58 INFO - 'HOME': '/home/cltbld', 17:50:58 INFO - 'LANG': 'en_US.UTF-8', 17:50:58 INFO - 'LANGUAGE': 'en_US:en', 17:50:58 INFO - 'LOGNAME': 'cltbld', 17:50:58 INFO - 'MAIL': '/var/mail/cltbld', 17:50:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:50:58 INFO - 'MOZ_NO_REMOTE': '1', 17:50:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:50:58 INFO - 'NO_EM_RESTART': '1', 17:50:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:50:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:50:58 INFO - 'PWD': '/builds/slave/test', 17:50:58 INFO - 'SHELL': '/bin/bash', 17:50:58 INFO - 'SHLVL': '1', 17:50:58 INFO - 'TERM': 'linux', 17:50:58 INFO - 'TMOUT': '86400', 17:50:58 INFO - 'USER': 'cltbld', 17:50:58 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1502921563.454632-356199533', 17:50:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:50:58 INFO - '_': '/tools/buildbot/bin/python'} 17:50:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:50:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:50:58 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 17:50:58 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 17:50:58 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 17:50:58 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 17:50:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:50:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:50:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:50:59 INFO - Installing collected packages: mozsystemmonitor 17:50:59 INFO - Running setup.py install for mozsystemmonitor 17:50:59 INFO - Successfully installed mozsystemmonitor 17:50:59 INFO - Cleaning up... 17:50:59 INFO - Return code: 0 17:50:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:50: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')]} 17:50:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:50: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')]} 17:50:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:50: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', '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 0xc641f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd68a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf0bef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf090b0>, '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 0xf09fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf0a440>, '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': '1258088b6da462a47ba2cd90000001a2-1502921563.454632-356199533', '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 17:50: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:50: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 jsonschema==2.5.1 17:50:59 INFO - Using env: {'DISPLAY': ':0', 17:50:59 INFO - 'HOME': '/home/cltbld', 17:50:59 INFO - 'LANG': 'en_US.UTF-8', 17:50:59 INFO - 'LANGUAGE': 'en_US:en', 17:50:59 INFO - 'LOGNAME': 'cltbld', 17:50:59 INFO - 'MAIL': '/var/mail/cltbld', 17:50:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:50:59 INFO - 'MOZ_NO_REMOTE': '1', 17:50:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:50:59 INFO - 'NO_EM_RESTART': '1', 17:50:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:50:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:50:59 INFO - 'PWD': '/builds/slave/test', 17:50:59 INFO - 'SHELL': '/bin/bash', 17:50:59 INFO - 'SHLVL': '1', 17:50:59 INFO - 'TERM': 'linux', 17:50:59 INFO - 'TMOUT': '86400', 17:50:59 INFO - 'USER': 'cltbld', 17:50:59 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1502921563.454632-356199533', 17:50:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:50:59 INFO - '_': '/tools/buildbot/bin/python'} 17:50:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:51:00 INFO - Downloading/unpacking jsonschema==2.5.1 17:51: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 17:51: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 17:51: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 17:51: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 17:51:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:51:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:51:01 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 17:51:01 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 17:51:01 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 17:51:01 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 17:51:01 INFO - Downloading functools32-3.2.3-2.tar.gz 17:51:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:51:01 INFO - warning: no files found matching '*.txt' 17:51:01 INFO - no previously-included directories found matching 'build' 17:51:01 INFO - no previously-included directories found matching 'dist' 17:51:01 INFO - no previously-included directories found matching '.git*' 17:51:01 INFO - Installing collected packages: jsonschema, functools32 17:51:01 INFO - Running setup.py install for functools32 17:51:01 INFO - warning: no files found matching '*.txt' 17:51:01 INFO - no previously-included directories found matching 'build' 17:51:01 INFO - no previously-included directories found matching 'dist' 17:51:01 INFO - no previously-included directories found matching '.git*' 17:51:01 INFO - Successfully installed jsonschema functools32 17:51:01 INFO - Cleaning up... 17:51:01 INFO - Return code: 0 17:51:01 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:51:01 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')]} 17:51:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:51:01 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')]} 17:51:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:51:01 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 0xc641f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd68a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf0bef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf090b0>, '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 0xf09fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf0a440>, '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': '1258088b6da462a47ba2cd90000001a2-1502921563.454632-356199533', '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 17:51:01 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 17:51:01 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 17:51:01 INFO - Using env: {'DISPLAY': ':0', 17:51:01 INFO - 'HOME': '/home/cltbld', 17:51:01 INFO - 'LANG': 'en_US.UTF-8', 17:51:01 INFO - 'LANGUAGE': 'en_US:en', 17:51:01 INFO - 'LOGNAME': 'cltbld', 17:51:01 INFO - 'MAIL': '/var/mail/cltbld', 17:51:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:51:01 INFO - 'MOZ_NO_REMOTE': '1', 17:51:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:51:01 INFO - 'NO_EM_RESTART': '1', 17:51:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:51:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:51:01 INFO - 'PWD': '/builds/slave/test', 17:51:01 INFO - 'SHELL': '/bin/bash', 17:51:01 INFO - 'SHLVL': '1', 17:51:01 INFO - 'TERM': 'linux', 17:51:01 INFO - 'TMOUT': '86400', 17:51:01 INFO - 'USER': 'cltbld', 17:51:01 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1502921563.454632-356199533', 17:51:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:51:01 INFO - '_': '/tools/buildbot/bin/python'} 17:51:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:51:01 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:51:01 INFO - Cleaning up... 17:51:01 INFO - Return code: 0 17:51:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:51:01 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')]} 17:51:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:51:01 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')]} 17:51:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:51:01 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 0xc641f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd68a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf0bef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf090b0>, '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 0xf09fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf0a440>, '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': '1258088b6da462a47ba2cd90000001a2-1502921563.454632-356199533', '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 17:51:01 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 17:51:01 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 17:51:01 INFO - Using env: {'DISPLAY': ':0', 17:51:01 INFO - 'HOME': '/home/cltbld', 17:51:01 INFO - 'LANG': 'en_US.UTF-8', 17:51:01 INFO - 'LANGUAGE': 'en_US:en', 17:51:01 INFO - 'LOGNAME': 'cltbld', 17:51:01 INFO - 'MAIL': '/var/mail/cltbld', 17:51:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:51:01 INFO - 'MOZ_NO_REMOTE': '1', 17:51:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:51:01 INFO - 'NO_EM_RESTART': '1', 17:51:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:51:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:51:01 INFO - 'PWD': '/builds/slave/test', 17:51:01 INFO - 'SHELL': '/bin/bash', 17:51:01 INFO - 'SHLVL': '1', 17:51:01 INFO - 'TERM': 'linux', 17:51:01 INFO - 'TMOUT': '86400', 17:51:01 INFO - 'USER': 'cltbld', 17:51:01 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1502921563.454632-356199533', 17:51:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:51:01 INFO - '_': '/tools/buildbot/bin/python'} 17:51:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:51:01 INFO - Downloading/unpacking blobuploader==1.2.4 17:51:01 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 17:51:01 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 17:51:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:51:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:51:03 INFO - Downloading blobuploader-1.2.4.tar.gz 17:51:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:51:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:51: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 17:51: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 17:51: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 17:51: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 17:51:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:51:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:51: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 17:51: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 17:51: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 17:51: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 17:51:03 INFO - Downloading docopt-0.6.1.tar.gz 17:51:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:51:03 INFO - Installing collected packages: blobuploader, requests, docopt 17:51:03 INFO - Running setup.py install for blobuploader 17:51:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:51:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:51:03 INFO - Running setup.py install for requests 17:51:04 INFO - Running setup.py install for docopt 17:51:04 INFO - Successfully installed blobuploader requests docopt 17:51:04 INFO - Cleaning up... 17:51:04 INFO - Return code: 0 17:51:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:51: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')]} 17:51:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:51: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')]} 17:51:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:51:04 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 0xc641f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd68a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf0bef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf090b0>, '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 0xf09fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf0a440>, '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': '1258088b6da462a47ba2cd90000001a2-1502921563.454632-356199533', '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 17:51:04 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 17:51:04 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 17:51:04 INFO - Using env: {'DISPLAY': ':0', 17:51:04 INFO - 'HOME': '/home/cltbld', 17:51:04 INFO - 'LANG': 'en_US.UTF-8', 17:51:04 INFO - 'LANGUAGE': 'en_US:en', 17:51:04 INFO - 'LOGNAME': 'cltbld', 17:51:04 INFO - 'MAIL': '/var/mail/cltbld', 17:51:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:51:04 INFO - 'MOZ_NO_REMOTE': '1', 17:51:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:51:04 INFO - 'NO_EM_RESTART': '1', 17:51:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:51:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:51:04 INFO - 'PWD': '/builds/slave/test', 17:51:04 INFO - 'SHELL': '/bin/bash', 17:51:04 INFO - 'SHLVL': '1', 17:51:04 INFO - 'TERM': 'linux', 17:51:04 INFO - 'TMOUT': '86400', 17:51:04 INFO - 'USER': 'cltbld', 17:51:04 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1502921563.454632-356199533', 17:51:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:51:04 INFO - '_': '/tools/buildbot/bin/python'} 17:51:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:51:04 INFO - Running setup.py (path:/tmp/pip-jBQL1q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:51:04 INFO - Running setup.py (path:/tmp/pip-_33JTG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:51:04 INFO - Running setup.py (path:/tmp/pip-C_LqJM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:51:04 INFO - Running setup.py (path:/tmp/pip-PPujuq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:51:04 INFO - Running setup.py (path:/tmp/pip-gc7YLi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:51:04 INFO - Running setup.py (path:/tmp/pip-n_uQPt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:51:04 INFO - Running setup.py (path:/tmp/pip-ZkfT9u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:51:05 INFO - Running setup.py (path:/tmp/pip-fKnr7q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:51:05 INFO - Running setup.py (path:/tmp/pip-qFM0eX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:51:05 INFO - Running setup.py (path:/tmp/pip-j86vui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:51:05 INFO - Running setup.py (path:/tmp/pip-C7jfyo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:51:05 INFO - Running setup.py (path:/tmp/pip-oOitIJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:51:05 INFO - Running setup.py (path:/tmp/pip-vuWoqr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:51:05 INFO - Running setup.py (path:/tmp/pip-qbCLrH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:51:05 INFO - Running setup.py (path:/tmp/pip-NcKYy4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:51:05 INFO - Running setup.py (path:/tmp/pip-muKaCc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:51:05 INFO - Running setup.py (path:/tmp/pip-cli3uQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:51:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:51:05 INFO - Running setup.py install for manifestparser 17:51:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:51:05 INFO - Running setup.py install for mozcrash 17:51:05 INFO - Running setup.py install for mozdebug 17:51:06 INFO - Running setup.py install for mozdevice 17:51:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:51:06 INFO - Running setup.py install for mozfile 17:51:06 INFO - Running setup.py install for mozhttpd 17:51:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:51:06 INFO - Running setup.py install for mozinfo 17:51:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:51:06 INFO - Running setup.py install for mozInstall 17:51:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:51:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:51:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:51:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:51:06 INFO - Running setup.py install for mozleak 17:51:06 INFO - Running setup.py install for mozlog 17:51:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:51:06 INFO - Running setup.py install for moznetwork 17:51:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:51:06 INFO - Running setup.py install for mozprocess 17:51:07 INFO - Running setup.py install for mozprofile 17:51:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:51:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:51:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:51:07 INFO - Running setup.py install for mozrunner 17:51:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:51:07 INFO - Running setup.py install for mozscreenshot 17:51:07 INFO - Running setup.py install for moztest 17:51:07 INFO - Running setup.py install for mozversion 17:51:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:51:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:51:07 INFO - Cleaning up... 17:51:07 INFO - Return code: 0 17:51:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:51:07 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')]} 17:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:51:07 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')]} 17:51:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:51:07 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 0xc641f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd68a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf0bef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf090b0>, '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 0xf09fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf0a440>, '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': '1258088b6da462a47ba2cd90000001a2-1502921563.454632-356199533', '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 17:51:07 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 17:51:07 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 17:51:07 INFO - Using env: {'DISPLAY': ':0', 17:51:07 INFO - 'HOME': '/home/cltbld', 17:51:07 INFO - 'LANG': 'en_US.UTF-8', 17:51:07 INFO - 'LANGUAGE': 'en_US:en', 17:51:07 INFO - 'LOGNAME': 'cltbld', 17:51:07 INFO - 'MAIL': '/var/mail/cltbld', 17:51:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:51:07 INFO - 'MOZ_NO_REMOTE': '1', 17:51:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:51:07 INFO - 'NO_EM_RESTART': '1', 17:51:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:51:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:51:07 INFO - 'PWD': '/builds/slave/test', 17:51:07 INFO - 'SHELL': '/bin/bash', 17:51:07 INFO - 'SHLVL': '1', 17:51:07 INFO - 'TERM': 'linux', 17:51:07 INFO - 'TMOUT': '86400', 17:51:07 INFO - 'USER': 'cltbld', 17:51:07 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1502921563.454632-356199533', 17:51:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:51:07 INFO - '_': '/tools/buildbot/bin/python'} 17:51:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:51:07 INFO - Running setup.py (path:/tmp/pip-PUo_NH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:51:07 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)) 17:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:51:07 INFO - Running setup.py (path:/tmp/pip-tb3m1Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:51:07 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)) 17:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:51:07 INFO - Running setup.py (path:/tmp/pip-CbdV8x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:51:07 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)) 17:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:51:07 INFO - Running setup.py (path:/tmp/pip-LXBUY5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:51:08 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)) 17:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:51:08 INFO - Running setup.py (path:/tmp/pip-vPW2Vg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:51:08 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)) 17:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:51:08 INFO - Running setup.py (path:/tmp/pip-BN9Hu1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:51:08 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)) 17:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:51:08 INFO - Running setup.py (path:/tmp/pip-IF1Sx_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:51:08 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)) 17:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:51:08 INFO - Running setup.py (path:/tmp/pip-Kt6unJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:51:08 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)) 17:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:51:08 INFO - Running setup.py (path:/tmp/pip-4EPwgJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:51:08 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)) 17:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:51:08 INFO - Running setup.py (path:/tmp/pip-S11gZh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:51:08 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)) 17:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:51:08 INFO - Running setup.py (path:/tmp/pip-NgRbvL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:51:08 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)) 17:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:51:08 INFO - Running setup.py (path:/tmp/pip-MWHtfl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:51:08 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)) 17:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:51:08 INFO - Running setup.py (path:/tmp/pip-MNDNTD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:51:08 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)) 17:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:51:08 INFO - Running setup.py (path:/tmp/pip-wulH0a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:51:08 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)) 17:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:51:08 INFO - Running setup.py (path:/tmp/pip-D47wKA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:51:08 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)) 17:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:51:08 INFO - Running setup.py (path:/tmp/pip-_DQrm3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:51:08 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)) 17:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:51:08 INFO - Running setup.py (path:/tmp/pip-rkXv1I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:51:09 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)) 17:51:09 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)) 17:51:09 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)) 17:51:09 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)) 17:51:09 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)) 17:51:09 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)) 17:51:09 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)) 17:51:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:51:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:51:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:51:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:51:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:51:10 INFO - Downloading blessings-1.6.tar.gz 17:51:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:51:10 INFO - Installing collected packages: blessings 17:51:10 INFO - Running setup.py install for blessings 17:51:10 INFO - Successfully installed blessings 17:51:10 INFO - Cleaning up... 17:51:10 INFO - Return code: 0 17:51:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:51:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:51:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:51:10 INFO - Reading from file tmpfile_stdout 17:51:10 INFO - Current package versions: 17:51:10 INFO - argparse == 1.2.1 17:51:10 INFO - blessings == 1.6 17:51:10 INFO - blobuploader == 1.2.4 17:51:10 INFO - docopt == 0.6.1 17:51:10 INFO - functools32 == 3.2.3-2 17:51:10 INFO - jsonschema == 2.5.1 17:51:10 INFO - manifestparser == 1.1 17:51:10 INFO - mozInstall == 1.13 17:51:10 INFO - mozcrash == 1.0 17:51:10 INFO - mozdebug == 0.1 17:51:10 INFO - mozdevice == 0.51 17:51:10 INFO - mozfile == 1.2 17:51:10 INFO - mozhttpd == 0.7 17:51:10 INFO - mozinfo == 0.10 17:51:10 INFO - mozleak == 0.1 17:51:10 INFO - mozlog == 3.5 17:51:10 INFO - moznetwork == 0.27 17:51:10 INFO - mozprocess == 0.25 17:51:10 INFO - mozprofile == 0.28 17:51:10 INFO - mozrunner == 6.13 17:51:10 INFO - mozscreenshot == 0.1 17:51:10 INFO - mozsystemmonitor == 0.3 17:51:10 INFO - moztest == 0.8 17:51:10 INFO - mozversion == 1.4 17:51:10 INFO - psutil == 3.1.1 17:51:10 INFO - requests == 1.2.3 17:51:10 INFO - wsgiref == 0.1.2 17:51:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:51:10 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')]} 17:51:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:51:10 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')]} 17:51:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:51:10 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 0xc641f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd68a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf0bef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf090b0>, '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 0xf09fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf0a440>, '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': '1258088b6da462a47ba2cd90000001a2-1502921563.454632-356199533', '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 17:51:10 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 17:51:10 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 17:51:10 INFO - Using env: {'DISPLAY': ':0', 17:51:10 INFO - 'HOME': '/home/cltbld', 17:51:10 INFO - 'LANG': 'en_US.UTF-8', 17:51:10 INFO - 'LANGUAGE': 'en_US:en', 17:51:10 INFO - 'LOGNAME': 'cltbld', 17:51:10 INFO - 'MAIL': '/var/mail/cltbld', 17:51:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:51:10 INFO - 'MOZ_NO_REMOTE': '1', 17:51:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:51:10 INFO - 'NO_EM_RESTART': '1', 17:51:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:51:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:51:10 INFO - 'PWD': '/builds/slave/test', 17:51:10 INFO - 'SHELL': '/bin/bash', 17:51:10 INFO - 'SHLVL': '1', 17:51:10 INFO - 'TERM': 'linux', 17:51:10 INFO - 'TMOUT': '86400', 17:51:10 INFO - 'USER': 'cltbld', 17:51:10 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1502921563.454632-356199533', 17:51:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:51:10 INFO - '_': '/tools/buildbot/bin/python'} 17:51:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:51:10 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)) 17:51:10 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)) 17:51:10 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)) 17:51:10 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)) 17:51:10 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)) 17:51:10 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)) 17:51:10 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)) 17:51:10 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)) 17:51:10 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)) 17:51:10 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 17:51:10 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 17:51:10 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 17:51:10 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 17:51:10 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 17:51:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 17:51:11 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)) 17:51:11 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)) 17:51:11 INFO - Installing collected packages: simplejson 17:51:11 INFO - Running setup.py install for simplejson 17:51:12 INFO - building 'simplejson._speedups' extension 17:51:12 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 17:51:12 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 17:51:12 INFO - Successfully installed simplejson 17:51:12 INFO - Cleaning up... 17:51:13 INFO - Return code: 0 17:51:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:51:13 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')]} 17:51:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:51:13 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')]} 17:51:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:51:13 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 0xc641f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd68a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf0bef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf090b0>, '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 0xf09fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf0a440>, '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': '1258088b6da462a47ba2cd90000001a2-1502921563.454632-356199533', '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 17:51:13 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 17:51:13 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 17:51:13 INFO - Using env: {'DISPLAY': ':0', 17:51:13 INFO - 'HOME': '/home/cltbld', 17:51:13 INFO - 'LANG': 'en_US.UTF-8', 17:51:13 INFO - 'LANGUAGE': 'en_US:en', 17:51:13 INFO - 'LOGNAME': 'cltbld', 17:51:13 INFO - 'MAIL': '/var/mail/cltbld', 17:51:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:51:13 INFO - 'MOZ_NO_REMOTE': '1', 17:51:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:51:13 INFO - 'NO_EM_RESTART': '1', 17:51:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:51:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:51:13 INFO - 'PWD': '/builds/slave/test', 17:51:13 INFO - 'SHELL': '/bin/bash', 17:51:13 INFO - 'SHLVL': '1', 17:51:13 INFO - 'TERM': 'linux', 17:51:13 INFO - 'TMOUT': '86400', 17:51:13 INFO - 'USER': 'cltbld', 17:51:13 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1502921563.454632-356199533', 17:51:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:51:13 INFO - '_': '/tools/buildbot/bin/python'} 17:51:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:51:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:51:13 INFO - Cleaning up... 17:51:13 INFO - Return code: 0 17:51:13 INFO - Running post-action listener: _resource_record_post_action 17:51:13 INFO - Running post-action listener: _start_resource_monitoring 17:51:13 INFO - Starting resource monitoring. 17:51:13 INFO - [mozharness: 2017-08-17 00:51:13.281557Z] Finished create-virtualenv step (success) 17:51:13 INFO - [mozharness: 2017-08-17 00:51:13.282132Z] Running install step. 17:51:13 INFO - Running pre-action listener: _resource_record_pre_action 17:51:13 INFO - Running main action method: install 17:51:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:51:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:51:13 INFO - Reading from file tmpfile_stdout 17:51:13 INFO - Detecting whether we're running mozinstall >=1.0... 17:51:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:51:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:51:13 INFO - Reading from file tmpfile_stdout 17:51:13 INFO - Output received: 17:51:13 INFO - Usage: mozinstall [options] installer 17:51:13 INFO - Options: 17:51:13 INFO - -h, --help show this help message and exit 17:51:13 INFO - -d DEST, --destination=DEST 17:51:13 INFO - Directory to install application into. [default: 17:51:13 INFO - "/builds/slave/test"] 17:51:13 INFO - --app=APP Application being installed. [default: firefox] 17:51:13 INFO - mkdir: /builds/slave/test/build/application 17:51:13 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'] 17:51:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 17:51:31 INFO - Reading from file tmpfile_stdout 17:51:31 INFO - Output received: 17:51:31 INFO - /builds/slave/test/build/application/firefox/firefox 17:51:31 INFO - Running post-action listener: _resource_record_post_action 17:51:31 INFO - [mozharness: 2017-08-17 00:51:31.580037Z] Finished install step (success) 17:51:31 INFO - [mozharness: 2017-08-17 00:51:31.580292Z] Running setup-mitmproxy step. 17:51:31 INFO - Running pre-action listener: _resource_record_pre_action 17:51:31 INFO - Running main action method: setup_mitmproxy 17:51:31 INFO - Skipping: mitmproxy is not required 17:51:31 INFO - Running post-action listener: _resource_record_post_action 17:51:31 INFO - [mozharness: 2017-08-17 00:51:31.581456Z] Finished setup-mitmproxy step (success) 17:51:31 INFO - [mozharness: 2017-08-17 00:51:31.581815Z] Running run-tests step. 17:51:31 INFO - Running pre-action listener: _resource_record_pre_action 17:51:31 INFO - Running pre-action listener: _set_gcov_prefix 17:51:31 INFO - Running main action method: run_tests 17:51:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:51:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:51:31 INFO - Python 2.7.3 17:51:31 INFO - Return code: 0 17:51:31 INFO - grabbing minidump binary from tooltool 17:51:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:51:31 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/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 0xf090b0>, '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 0xf09fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf0a440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:51:31 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 17:51:31 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 17:51:31 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 17:51:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:51:31 INFO - Return code: 0 17:51:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:51:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:51:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:51:31 INFO - ENV: RUST_BACKTRACE is now full 17:51:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:51:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:51:31 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/VGVatiFiSBqe2fkjUp-Rdg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-079', '--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 17:51:31 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/VGVatiFiSBqe2fkjUp-Rdg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-079 --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 17:51:31 INFO - Using env: {'DISPLAY': ':0', 17:51:31 INFO - 'HOME': '/home/cltbld', 17:51:31 INFO - 'LANG': 'en_US.UTF-8', 17:51:31 INFO - 'LANGUAGE': 'en_US:en', 17:51:31 INFO - 'LOGNAME': 'cltbld', 17:51:31 INFO - 'MAIL': '/var/mail/cltbld', 17:51:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:51:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:51:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:51:31 INFO - 'MOZ_NO_REMOTE': '1', 17:51:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:51:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:51:31 INFO - 'NO_EM_RESTART': '1', 17:51:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:51:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:51:31 INFO - 'PWD': '/builds/slave/test', 17:51:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:51:31 INFO - 'RUST_BACKTRACE': 'full', 17:51:31 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:51:31 INFO - 'SHELL': '/bin/bash', 17:51:31 INFO - 'SHLVL': '1', 17:51:31 INFO - 'STYLO_FORCE_ENABLED': '1', 17:51:31 INFO - 'TERM': 'linux', 17:51:31 INFO - 'TMOUT': '86400', 17:51:31 INFO - 'USER': 'cltbld', 17:51:31 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1502921563.454632-356199533', 17:51:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:51:31 INFO - '_': '/tools/buildbot/bin/python'} 17:51:31 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/VGVatiFiSBqe2fkjUp-Rdg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-079', '--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 17:51:31 INFO - mozversion application_buildid: 20170816235940 17:51:31 INFO - mozversion application_changeset: 63ca686c3f1e870649b6d9c559973d100573aec2 17:51:31 INFO - mozversion application_display_name: Nightly 17:51:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:51:31 INFO - mozversion application_name: Firefox 17:51:31 INFO - mozversion application_remotingname: firefox 17:51:31 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:51:31 INFO - mozversion application_vendor: Mozilla 17:51:31 INFO - mozversion application_version: 57.0a1 17:51:31 INFO - mozversion platform_buildid: 20170816235940 17:51:31 INFO - mozversion platform_changeset: 63ca686c3f1e870649b6d9c559973d100573aec2 17:51:31 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:51:31 INFO - mozversion platform_version: 57.0a1 17:51:31 INFO - using testdate: 1502931091 17:51:31 INFO - actual date: 1502931091 17:51:31 INFO - starting webserver on 'localhost:32974' 17:51:31 INFO - SUITE-START | Running 2 tests 17:51:31 INFO - TEST-START | dromaeo_css 17:51:31 INFO - Initialising browser for dromaeo_css test... 17:51:31 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:32974/getInfo.html -profile /tmp/tmpAx2BVI/profile 17:51:31 INFO - TEST-INFO | started process 8691 (/builds/slave/test/build/application/firefox/firefox http://localhost:32974/getInfo.html) 17:51:38 INFO - TEST-INFO | 8691: exit 0 17:51:38 INFO - Browser initialized. 17:51:38 INFO - Running cycle 1/1 for dromaeo_css test... 17:51:38 INFO - TEST-INFO | started process 8882 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAx2BVI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:51:39 INFO - PID 8882 | 17:51:39 INFO - PID 8882 | (/builds/slave/test/build/application/firefox/firefox:8936): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:51:39 INFO - PID 8882 | 17:51:49 INFO - PID 8882 | RSS: Main: 170627072 17:51:49 INFO - PID 8882 | 17:54:48 INFO - PID 8882 | Cycle 1(1): loaded http://localhost:32974/tests/dromaeo/cssquery-dojo.html (next: http://localhost:32974/tests/dromaeo/cssquery-ext.html) 17:54:50 INFO - PID 8882 | RSS: Main: 175271936 17:54:50 INFO - PID 8882 | 17:57:52 INFO - PID 8882 | Cycle 1(1): loaded http://localhost:32974/tests/dromaeo/cssquery-ext.html (next: http://localhost:32974/tests/dromaeo/cssquery-jquery.html) 17:57:52 INFO - PID 8882 | RSS: Main: 172630016 17:57:52 INFO - PID 8882 | 18:00:54 INFO - PID 8882 | Cycle 1(1): loaded http://localhost:32974/tests/dromaeo/cssquery-jquery.html (next: http://localhost:32974/tests/dromaeo/cssquery-mootools.html) 18:00:55 INFO - PID 8882 | RSS: Main: 173187072 18:00:55 INFO - PID 8882 | 18:03:57 INFO - PID 8882 | Cycle 1(1): loaded http://localhost:32974/tests/dromaeo/cssquery-mootools.html (next: http://localhost:32974/tests/dromaeo/cssquery-prototype.html) 18:03:57 INFO - PID 8882 | RSS: Main: 172961792 18:03:57 INFO - PID 8882 | 18:07:01 INFO - PID 8882 | Cycle 1(1): loaded http://localhost:32974/tests/dromaeo/cssquery-prototype.html (next: http://localhost:32974/tests/dromaeo/cssquery-yui.html) 18:07:02 INFO - PID 8882 | RSS: Main: 176328704 18:07:02 INFO - PID 8882 | 18:10:04 INFO - PID 8882 | Cycle 1(1): loaded http://localhost:32974/tests/dromaeo/cssquery-yui.html (next: http://localhost:32974/tests/dromaeo/cssquery-dojo.html) 18:10:04 INFO - PID 8882 | RSS: Main: 176443392 18:10:04 INFO - PID 8882 | 18:10:04 INFO - PID 8882 | __start_tp_report 18:10:04 INFO - PID 8882 | _x_x_mozilla_page_load 18:10:04 INFO - PID 8882 | _x_x_mozilla_page_load_details 18:10:04 INFO - PID 8882 | |i|pagename|runs| 18:10:04 INFO - PID 8882 | |0;dojo.html;3157.368526294741;3165.1928758166678;3194.488881778913;3210.566573512576;3229.9677003229963;6272.059191121334;6351.396617321353;6374.490040796737;6384.201974753156;6406.007068904316;6151.81544553663;6223.502119830414;6243.125962365261;6261.998080307152;6262.749490020405;5752.511036561887;5767.538596912237;5800.071988481844;5803.448672376117;5825.038868586678;5791.189233507313;5791.681457519835;5801.709914504279;5821.970890145543;5838.503727183194;5872.324682661484;5883.646981181143;5910.822675319747;5951.107333899907;5997.310309314419;5726.3414707308775;5781.855453613652;5812.709364531799;5830.475257226849;5864.76540938362;5381;5582.91625625616;5741.081426971707;5755.68343741094;5780.0751879699465;6068.241469816273;6172.660503672296;6221.9377806222265;6273.811785646438;6309.810705678837;6706.362895524917;6725.562838415487;6810.9318906810795;6814.863702725917;6831.11195544581;6718.05947167397;6782.253952065318;6810;6812.795616131524;6887.173539175281;6287.088372186007;6296.150019747367;6322.304546499881;6325.209348831396;6332.145160403379;6934.826629334307;6947.756828510978;7028.859422811515;7045.084139061889;7074.186468556079;6603.7358505660195;6649;6657.40083392497;6743.291954344723;6756.290589488033;6630.7679231226675;6755.290694477009;6798.286179951133;6893.379595836399;6895.793126206222;6668.199816022108;6690.464762818963;6727.730890764315;6767.796966091025;6783.93216067833;6730.32696730323;6791.456683465311;6814.1482314710665;6823.078884350549;6852.897206541906;5403.297571315782;5408.215808707715;5464.9180262296095;5483.945160548344;5487.259220005328;4616.584507394351;4628.652851036186;4689.812407503729;4712.6229901607785;4722.220833562424;5733.799317023884;5767.596268261265;5818.156367326714;5829.650220986754;5848.0350742127075;6839.829004274933;6883.7590684325805;6894.103766510422;6899.724011039602;6920.792376228721;5683.920055189501;5766.365699773021;5837.854053648608;5846.210761547137;5850.64896106235;5778.248827652463;5893.499052580493;5894.086416605433;5896.174535565025;5912.940870591325;6498.967505162444;6510.674466276667;6517.837054073686;6519.706613202417;6520.0871877937125;6713.160854893138;6759.188897332155;6838.0084887692;6875.278095799869;6884.48366372514;6599.8020059398295;6691.799246022432;6703.564268322543;6705.564138331188;6708.563943343667;6659.134312539532;6708.396244338033;6715.3620406061345;6815.045893574805;6819.079424277659;6667.299933507106;6744;6754.054432379373;6757.729690812313;6895.034695142785;6578.638174900427;6588.8023359299295;6621.370969757865;6621.834454138492;6625.635590042594;6541.803745887631;6544.312847150981;6544.9672751635935;6579.4736421087155;6581.407673309425;6469.094326794158;6505.381988711065;6507.186601674791;6585.539012269287;6612.933870661232;6506.284308725942;6538.117354157128;6569.4744420447205;6657.334266573498;6685.8328541784895;6382.457491113121;6400.839979000562;6405.647689377129;6423.8394040147505;6428.485721142204 18:10:04 INFO - PID 8882 | |1;ext.html;737.8561180569791;802.7070119406417;827.329862811123;831.1356189562855;1157.2824848593862;29757.40485190295;40798.79600601996;41471;41523.96190095253;41631.583684163226;41370.37944430836;41534.16931661365;41688.37467437983;41756.79121604388;41773.58226417735;7138.678759455837;7551.773446796591;7704.229577042307;7704.653290601908;7751.418643601724;7513.849723005536;7581.507202031878;7611.200823913492;7617.162112167657;7638.045244344457;7639.770806875803;7648.120466146409;7690.6154692265445;7695.192004839495;7703.037120359955;7594.278543538355;7597.164311925684;7637.121731000895;7644;7663.386929045663;7494.325510704009;7516.436267279976;7518.962405187994;7557.886631700529;7564.243575642447;37427.25145497075;37475.62524374748;37537;37579.81210093959;37587;3438.6561343865415;3490.2495963367996;3494.4583589543663;3508.15804206991;3509.2630547585036;30506.38987220243;30527.389452211053;30645.846770766002;30648.2337941551;30679.693203067905;4838.6371022173125;5040.722760248185;5045;5072.492750724935;5087.287779710843;192248;193992;194720;194786;194930;47237.763811180725;47262.400567968405;47276;47328;47334.28998565024;47874.521254787;48091.27863082057;48128.27807582889;48169.75915120472;48275.517244827104;13424.127431716906;16032.519024429286;16224.513264602081;16230.51308460748;16244.51266462008;11053.778924421467;13318.600441986757;13358.666033349244;13359.73280534384;13440.798388024188;13679.86320136786;13773.793393099111;13950.930245348709;14000.369983350774;14074.788878166835;5612.522935550524;5620.634658747168;5668.149777533321;5723.814944629137;5732.484076433057;987.2546227598261;999.1307562420741;1021.2544842265039;1033.3593172233113;1038.2109596706407;22723.43360337418;22922.65616015761;22955.655665165035;23159.652605210937;23247.3025809226;1097.7969075721016;1098.1489345756943;1115.2472081345059;1116.4975760907623;1122.0742887117997;12030.4586293617;15938.28277727505;15970.76043859343;16418.26117824701;16446.588835278973;241750;241886;241952;243416;244024;56165.438345616836;56408.71795641078;56842.715786420806;56974.715126424104;57272;1445.4579532675248;1446.833614134388;1487.7991471151256;1489.2181604657642;1495.8803295736316;27149.1855244343;27665.58501622437;27689.169324920284;27710.307242318297;27792.305192369542;50309.74845125751;50800;50847;50991.49008510016;51036.48963510317;212577;213296;213725;215412;215516;34879.302413951074;37216;37877.81061094787;37956.430653540774;37999.43000854934;44942.77528612336;45320.773396132805;45333.09333813371;45780.31329530126;45788.54211457843;34114.82942585271;34213.144671383416;34461.310773784884;34505;34573;33568.16079598029;33594;33608;33723;34263.143421414665;37068;37279.06802329963;37522.624773751915;37535;37630.811845940596;32200;32738.836305818317;32857.17857053593;33085;33302;24019;24765;24813.87593062023;25149.74850251547;25244.368890777143 18:10:04 INFO - PID 8882 | |2;jquery.html;555.6860373888752;562.4038519169678;569.9544036477082;584.2054805464569;584.4944123333316;21330.89334553327;22049.779502204972;22152.113915443384;22185.334439966806;22703.20538781143;26072.47855042898;26654;26705.732942670616;26718.732812671868;26753.464930701375;6049.153118563416;6139.969300153493;6185.072239164139;6186.536009799261;6186.876262474748;5777.537796976232;6018.548608854353;6269.749210031593;6275.529335299848;6289.559730818844;6270.278917924428;6272.68636568172;6275.780347687832;6279.309275979638;6281.43467087962;6236.18929539157;6237.875242495147;6250.562460627758;6261.96869015652;6266.342034086424;5774.855628609276;5777.682227477487;5845.152452894349;5858.209141765849;5859.882802343972;28312.71687283142;28813.135605931646;29395.853020734972;29871.253218669706;30121.246968825737;1959.804019598043;1999.8400127989726;2012.537116463207;2016.395081475566;2025.382258411184;18506.44480665582;19111.90444047771;19145.234190632356;19203.61592768151;19214;2385.666006759055;2423.9878800605884;2476.950460990788;2481.8759062046825;2485.987570062156;130711;134194;134355;134448;134493;14217.92891035559;14777.778333325008;15052.247387630574;15119.773203401957;15542.5337239883;23248.65127023096;23748.64377034346;23759.1684291049;23779;23829.642555361683;10525.789484210427;10663.946680266548;10723.356598604109;10725.678229653124;10852.620158294421;8283.337333013344;9915.454649994319;9923.801523969625;9950;10076;8304.958475207586;9290.210332121846;9456;9464.19554337889;9562.235021198287;2720.9865448463356;2743.1359121876544;2767.557190849495;2772.542530482488;2883.740463358308;939.6288466056006;969.1713584884963;978.6427953796813;986.6250824686573;993.5876611206269;19976.60046799056;20184.89907550482;20308.883011434515;20413.16281534669;20438.59122817535;1029.45953374479;1051.3218973762034;1053.489057806963;1054.9894501054891;1064.8455973883742;11241.494132764044;11344;11412.201145919706;11451.713707157387;11477.483513241925;453428;459424;465823;470553;491183;114519.42740286412;115771;117463.41268293603;117688;118605.4069729663;1171.6777886081225;1173.700706319883;1209.0992210802833;1209.631062525938;1212.0606529939191;17655.823441765417;17725.650687495116;18125.27498900082;18203.816751911083;18452;53835.461645383046;54512.45487545233;55596;65100.674496627216;66873.33126668671;81255;81301.59349203216;82096;84875.5756221215;85856.14143858482;16853.91573042176;21679;22328.330150095524;22652.433689157904;22963;23058.654120188545;23977.640335394633;24585.262442126765;24604.261872143863;24831.87584062068;17990;18674.439766807016;18674.439766807016;18680.7197892029;18684.159212835184;17444.127793610016;17502;17516.737248941532;18322.450326490227;18327.541811454288;18300.72548911794;18882.811171888105;18985.335513257523;19060.428187154408;19300.517487062934;21586.460338491663;21965.23121690733;22049;22079.779202208414;22318.330450086523;18620.813791861907;19143.521411964255;19343.613127737084;19477.123529440927;19484.1232144551 18:10:04 INFO - PID 8882 | |3;mootools.html;1373.5124030969005;1413.265102146883;1434.8278206615207;1437.7915202295667;1446.1034158821528;14005;14602.926985365071;14659.41362345505;14668.11991280524;15006.174660393674;14750.631234219123;14997.10017398957;15026.398944042225;15028.173450460221;15052.849471505282;2589.223233030093;2677.263752468067;2721.4965231432247;2730.5085084684747;2731.112388473744;2731.2489065506948;2751.9587206191923;2766.14249582629;2770.252031951372;2774.667039955208;2708.0927889157156;2713.592961055838;2718.2796558911905;2739.369944912671;2746.7115952824965;2662.267876334004;2680.5041067402594;2691.636629055082;2705.0937935791535;2730.30377253799;2669.279294590469;2675.331167208198;2688.086050742757;2688.502627014009;2689.99125328002;14051.156930584199;14274.857251427457;14448.205348705817;14463.566093017227;14476.855231447656;7786.299233068994;8112.675492980274;8126.878096828552;8146.266835984789;8170;5201.427842937273;5338.786448542053;5392.4337944515655;5452.1276595744885;5456.399796022434;1813.564744461333;1820.1718218210815;1837.6692195404821;1858.1731129647312;1860.8697391182623;23860.64209036866;24114.39714007146;24173.87913060441;24219.757802422104;24266.39334016646;6416.679166041679;6596.4393026592315;6655;6803.965980170067;6849.486288528281;16442.095684737214;16442.177891105635;16474.83525164757;16502.42241521541;16544.6691066178;7598.468107232551;7752.6898924043535;7763.301302882654;7768.961155194188;7769.961150194326;7081.256468070881;7130.714771409189;7232.20445750967;7253.202147763742;7284.635768211569;5071.366079240095;5215.16557350822;5216.556592689664;5229.032628963654;5262.158054711228;1419.822522184727;1441.3730027438098;1446.378057435313;1456.6940942402214;1467.8385377608454;883.1212943121507;910.6266430763355;917.6467060181878;927.4945154890601;928.8049509602924;7556.2443755624;7655.540667559964;7715.652795624211;8577.957110214535;8581.613827377783;708.9334589671051;711.2851584157888;716.5127713155;717.1394326807851;736.37408203027;5041.269015992661;5358.356997160366;5417.59368047398;5459.262999495097;5512.448755124456;19259.32592359289;19847.20611175566;20130;20160.899195503927;20268;19009.239630414904;19988;20203.79796202019;20271.391858244275;20311.086001129985;10564.735881602868;10865.51105200268;10872.402017888933;10876.129909607054;10949.069329106957;8459.323254139777;8650.567471626267;8721.912780872364;8827.293816494794;8936.106389361012;16924.32302707878;17252.65494690074;17295.135243237535;17446.563835903697;17555.122243887497;16453.83546164523;16464.753028704818;16496.42262520806;16700.248488818277;16781.244843981807;11558.653240402802;11816.822747658964;11817.468213930222;11823.113266504875;11832.940835295769;13354.332283385986;13484.932575337061;13570.253636050113;13631.250281234627;13707.383167757675;11036.11711063129;11090.500927458123;11129.387883666475;11324.433778310886;11367.431628418712;10912.127029837435;11047.337159770439;11088.778224435628;11105.222634415513;11168.1065514757;9538.618455261712;9667.468289243878;9839.557219924978;9847.31068825204;9852.655157069468;7160.069191005136;7288.198298187089;7311.3785328247695;7326.853462930818;7422.480426370318;7369.742059027908;7413.147488038944;7480.925190748023;7532.472726909064;7536.208698086622 18:10:04 INFO - PID 8882 | |4;prototype.html;496.3621746056316;498.0767334056615;514.4264145477794;522.5245027025408;529.5710474515643;6296.338884417139;6316.242050953886;6325.36291632311;6338.144350512679;6394.456471199954;5930.703464826752;6109.969450152743;6132.417420345071;6166.414190651881;6195.2255968004;4902.828401005965;4948.901021979558;4953.851384458472;4980.389217817072;5029.321041659366;4920.23736320869;4958.925616115761;4966.329545511346;5014.398272207341;5080.77136528857;5110.28456016158;5160.406553246368;5204.635675502716;5234.7120908350025;5255.710935898524;5172.32759741235;5182.408795602199;5215.817446389377;5225.686458812445;5243.397009343936;4834.758262086917;4862.465128835825;4869.440014398354;4889.071076495455;4927.704337739747;6083.209182806207;6124.540659450559;6153.692315384213;6164.260288765377;6164.5923164937285;5972.25346831646;6066.939330606681;6075.179850720185;6111;6175.4442100210745;6574.572652777602;6612.173478315211;6616.636085015322;6635.568688035262;6654.301298363651;5282.3624676350455;5344.118220493614;5369.221462887859;5370.5435038021815;5400.702961337125;6937.618430986294;6955.826104347432;6976.5116441849095;7039.627272681829;7100.92899071013;5455.745178608863;5478.780848766005;5485.670859748428;5512.448755124536;5533.474319939599;5577;5588.385277619459;5601.719914004283;5602.747876345574;5621.161313536638;5994.422398368743;6033.939660603338;6071.392860713893;6100.359462256488;6129.662868542273;6613.702383392759;6693.364130407604;6752.155980502437;6756.425703815133;6760.628165450948;1866.1788812922541;1923.538350795799;1923.7114432835187;1959.8530110241788;1985;1446.7395868743727;1455;1455.5778824141091;1466.7286551987916;1474.370820243637;5757.913631295534;5763.9135412968;5769.798057067983;5803.187553742479;5815.651060936273;6571.310012448624;6764.347252483603;6765.594064356154;6783.3555812197765;6848.657567121723;5741.85645358861;5770.971145144247;5797.4782269595935;5815.389384114692;5833.620814647034;3564.3049605327233;3564.8574057037945;3578.6958108561066;3641.253543023674;3652.6529979652423;6580.80257592273;6599.373059559334;6621.735130594819;6647.235567909753;6665.200175978816;6900.413464855443;6943.89584156238;7006.894896576556;7016.473764467685;7076.363127318566;6535.581834721183;6542.887709089371;6574.76988305407;6607;6637.966810165918;6676.83307917306;6803.795886123424;6803.877360235506;6804.897926531007;6916.446684265347;6731.360520750521;6754.392104710403;6757.831054223684;6792.762253321308;6805.659717014229;6566.474682025331;6678.465722742072;6683.198016238082;6695.698693558899;6708.798736037927;4961.404631444249;4986.626003049713;5029.572486338702;5031;5057.721825299644;6801.2858649841055;6835.692393842389;6836.863262734618;6853.383195512428;6884.311568843075;6600.504962127956;6600.60396376219;6611.2727599963;6615.470762338905;6671.166104236971;6519.217693876765;6579.605223686594;6592.736290548324;6605.405513503808;6631.933680663325;6215.9378406217165;6226.657533835682;6306.779262725782;6390.297067322498;6427.907255766438;6462.705739462611;6469.77355792545;6502.967485162544;6611.900821487586;6633.303503132294;6220.844478888064;6238.126662267196;6276.843078923063;6354.110424540476;6385.457236134795 18:10:04 INFO - PID 8882 | |5;yui.html;912.2610685344871;920.0891117793384;921.4517362169511;924.2790623313817;928.8142371525695;17166.65666686667;17186.484405467825;17230.655386892286;17255.396061137864;22472.213472528463;17794.911025444853;17859.91070044648;17940;17946.910265448656;17969.64060718788;1023.918086553074;1047.350642601588;1060.1148041385413;1061.8035663402256;1064.882862885082;1067.4716015572303;1069.1126365116934;1077.0629552289479;1077.1060020183268;1077.154433769491;1105.4748994227718;1111.183280288987;1120.38938778366;1120.4789772755666;1120.8094623913955;1108.141190577301;1109.6282745280341;1115.3865374044283;1115.8660960684688;1117.5976648406568;811.8579248631465;814.9103598604149;816.7182322098867;817.7301490508119;819.8442295963748;18528.3515076973;18540.07299635013;18541.35105271309;20351.69472457914;21018.474538136517;21743.67384489234;21942.451438714;22054.558908821895;22199.778002219933;22303.553928921494;16707.164641767984;16829.158542072848;16982.065986370744;17080.914595427068;17176.82823171765;3591.6947059499976;3617.9095522612147;3649.6350364963555;3650.4889315495852;3651.908702282438;130188.3490582541;131282;133524.33237833847;133954;135505.6449435503;16645.16774161287;17148.142592870307;17369.7394539082;17465.21406536709;17496.47510574685;29769.40461190764;31157.8442107788;31652.208694782814;31818.84090579532;31830.2042448936;8521.914780852236;8642.697505587274;8733;8776.078511756301;8816.911830881609;3745.569259535134;3923.1761330120426;4175.874723758292;4283;4298.742075475481;6130.356312587203;6286.182796236551;6298.086777417248;6303.3066362700065;6318.399752023551;1095.6329629574022;1141.5833220874488;1150.7238262816863;1152.5793085523892;1164.6447833410891;675.3887731602907;688.0607970120749;688.9758858439931;694.9131358580178;702.596007295807;12282.815757763641;12382.81425778614;12693.619191424272;13396.598102056954;13693.589192324247;673.4477728262777;675.3651567526509;676.7191615479619;690.927452617478;695.0755495191485;5659.971700141556;5699.116636921284;5822.854428639318;5854.619449735754;5861.413858614104;113264;115584;116140;117306;121846;102718;104426.47786761017;107142;107196.91304477955;109794;87522.56238718766;88752.5562372184;89698;90085.09914900898;91591;10837;10974.341539507655;10992.395418252074;11104.389258590854;11280.210385272952;39372.80313598413;39491.40762888616;40120;40980;42316;71912.64043679748;73396;73907.63046184949;75581.24418755741;77775.2222477768;19261.711074334176;19369.547283953478;19587.70618440696;19791.30730424428;19806.801931981074;19324.8067519323;19488.415347539598;19501.902490487457;19517.316893908646;19646.901765491082;18524.722129167803;18569.628607428047;18611.06944652735;19069.713954290975;19792.505187370432;18771.15529801135;19043.809561904756;19089.809101908802;19219.8078019218;20212.19151233993;18343.26626934908;18737.812621873607;18823.811761882753;19276.32532861343;20085;12107.152499324962;12228.938855306022;12419.689507762378;12516.499340026661;12825.807612885628;13400.195988240737;13799.103058301178;13999.930000349934;14049.859501405264;14769.409223630935 18:10:04 INFO - PID 8882 | __end_tp_report 18:10:04 INFO - PID 8882 | __start_cc_report 18:10:04 INFO - PID 8882 | _x_x_mozilla_cycle_collect,381 18:10:04 INFO - PID 8882 | __end_cc_report 18:10:04 INFO - PID 8882 | __startTimestamp1502932204319__endTimestamp 18:10:04 INFO - PID 8882 | 18:10:04 INFO - PID 8882 | ------- Summary: start ------- 18:10:04 INFO - PID 8882 | Number of tests: 6 18:10:04 INFO - PID 8882 | 18:10:04 INFO - PID 8882 | [#0] dojo.html Cycles:165 Average:6229.26 Median:6505.38 stddev:747.23 (11.5%) stddev-sans-first:709.60 18:10:04 INFO - PID 8882 | Values: 3157.4 3165.2 3194.5 3210.6 3230.0 6272.1 6351.4 6374.5 6384.2 6406.0 6151.8 6223.5 6243.1 6262.0 6262.7 5752.5 5767.5 5800.1 5803.4 5825.0 5791.2 5791.7 5801.7 5822.0 5838.5 5872.3 5883.6 5910.8 5951.1 5997.3 5726.3 5781.9 5812.7 5830.5 5864.8 5381.0 5582.9 5741.1 5755.7 5780.1 6068.2 6172.7 6221.9 6273.8 6309.8 6706.4 6725.6 6810.9 6814.9 6831.1 6718.1 6782.3 6810.0 6812.8 6887.2 6287.1 6296.2 6322.3 6325.2 6332.1 6934.8 6947.8 7028.9 7045.1 7074.2 6603.7 6649.0 6657.4 6743.3 6756.3 6630.8 6755.3 6798.3 6893.4 6895.8 6668.2 6690.5 6727.7 6767.8 6783.9 6730.3 6791.5 6814.1 6823.1 6852.9 5403.3 5408.2 5464.9 5483.9 5487.3 4616.6 4628.7 4689.8 4712.6 4722.2 5733.8 5767.6 5818.2 5829.7 5848.0 6839.8 6883.8 6894.1 6899.7 6920.8 5683.9 5766.4 5837.9 5846.2 5850.6 5778.2 5893.5 5894.1 5896.2 5912.9 6499.0 6510.7 6517.8 6519.7 6520.1 6713.2 6759.2 6838.0 6875.3 6884.5 6599.8 6691.8 6703.6 6705.6 6708.6 6659.1 6708.4 6715.4 6815.0 6819.1 6667.3 6744.0 6754.1 6757.7 6895.0 6578.6 6588.8 6621.4 6621.8 6625.6 6541.8 6544.3 6545.0 6579.5 6581.4 6469.1 6505.4 6507.2 6585.5 6612.9 6506.3 6538.1 6569.5 6657.3 6685.8 6382.5 6400.8 6405.6 6423.8 6428.5 18:10:04 INFO - PID 8882 | 18:10:04 INFO - PID 8882 | [#1] ext.html Cycles:180 Average:39260.57 Median:20288.63 stddev:56487.92 (278.4%) stddev-sans-first:56572.33 18:10:04 INFO - PID 8882 | Values: 737.9 802.7 827.3 831.1 1157.3 29757.4 40798.8 41471.0 41524.0 41631.6 41370.4 41534.2 41688.4 41756.8 41773.6 7138.7 7551.8 7704.2 7704.7 7751.4 7513.8 7581.5 7611.2 7617.2 7638.0 7639.8 7648.1 7690.6 7695.2 7703.0 7594.3 7597.2 7637.1 7644.0 7663.4 7494.3 7516.4 7519.0 7557.9 7564.2 37427.3 37475.6 37537.0 37579.8 37587.0 3438.7 3490.2 3494.5 3508.2 3509.3 30506.4 30527.4 30645.8 30648.2 30679.7 4838.6 5040.7 5045.0 5072.5 5087.3 192248.0 193992.0 194720.0 194786.0 194930.0 47237.8 47262.4 47276.0 47328.0 47334.3 47874.5 48091.3 48128.3 48169.8 48275.5 13424.1 16032.5 16224.5 16230.5 16244.5 11053.8 13318.6 13358.7 13359.7 13440.8 13679.9 13773.8 13950.9 14000.4 14074.8 5612.5 5620.6 5668.1 5723.8 5732.5 987.3 999.1 1021.3 1033.4 1038.2 22723.4 22922.7 22955.7 23159.7 23247.3 1097.8 1098.1 1115.2 1116.5 1122.1 12030.5 15938.3 15970.8 16418.3 16446.6 241750.0 241886.0 241952.0 243416.0 244024.0 56165.4 56408.7 56842.7 56974.7 57272.0 1445.5 1446.8 1487.8 1489.2 1495.9 27149.2 27665.6 27689.2 27710.3 27792.3 50309.7 50800.0 50847.0 50991.5 51036.5 212577.0 213296.0 213725.0 215412.0 215516.0 34879.3 37216.0 37877.8 37956.4 37999.4 44942.8 45320.8 45333.1 45780.3 45788.5 34114.8 34213.1 34461.3 34505.0 34573.0 33568.2 33594.0 33608.0 33723.0 34263.1 37068.0 37279.1 37522.6 37535.0 37630.8 32200.0 32738.8 32857.2 33085.0 33302.0 24019.0 24765.0 24813.9 25149.7 25244.4 18:10:04 INFO - PID 8882 | 18:10:04 INFO - PID 8882 | [#2] jquery.html Cycles:180 Average:34979.85 Median:23010.83 stddev:79216.14 (344.3%) stddev-sans-first:79396.20 18:10:04 INFO - PID 8882 | Values: 555.7 562.4 570.0 584.2 584.5 21330.9 22049.8 22152.1 22185.3 22703.2 26072.5 26654.0 26705.7 26718.7 26753.5 6049.2 6140.0 6185.1 6186.5 6186.9 5777.5 6018.5 6269.7 6275.5 6289.6 6270.3 6272.7 6275.8 6279.3 6281.4 6236.2 6237.9 6250.6 6262.0 6266.3 5774.9 5777.7 5845.2 5858.2 5859.9 28312.7 28813.1 29395.9 29871.3 30121.2 1959.8 1999.8 2012.5 2016.4 2025.4 18506.4 19111.9 19145.2 19203.6 19214.0 2385.7 2424.0 2477.0 2481.9 2486.0 130711.0 134194.0 134355.0 134448.0 134493.0 14217.9 14777.8 15052.2 15119.8 15542.5 23248.7 23748.6 23759.2 23779.0 23829.6 10525.8 10663.9 10723.4 10725.7 10852.6 8283.3 9915.5 9923.8 9950.0 10076.0 8305.0 9290.2 9456.0 9464.2 9562.2 2721.0 2743.1 2767.6 2772.5 2883.7 939.6 969.2 978.6 986.6 993.6 19976.6 20184.9 20308.9 20413.2 20438.6 1029.5 1051.3 1053.5 1055.0 1064.8 11241.5 11344.0 11412.2 11451.7 11477.5 453428.0 459424.0 465823.0 470553.0 491183.0 114519.4 115771.0 117463.4 117688.0 118605.4 1171.7 1173.7 1209.1 1209.6 1212.1 17655.8 17725.7 18125.3 18203.8 18452.0 53835.5 54512.5 55596.0 65100.7 66873.3 81255.0 81301.6 82096.0 84875.6 85856.1 16853.9 21679.0 22328.3 22652.4 22963.0 23058.7 23977.6 24585.3 24604.3 24831.9 17990.0 18674.4 18674.4 18680.7 18684.2 17444.1 17502.0 17516.7 18322.5 18327.5 18300.7 18882.8 18985.3 19060.4 19300.5 21586.5 21965.2 22049.0 22079.8 22318.3 18620.8 19143.5 19343.6 19477.1 19484.1 18:10:04 INFO - PID 8882 | 18:10:04 INFO - PID 8882 | [#3] mootools.html Cycles:180 Average:8983.31 Median:2684.30 stddev:6127.98 (228.3%) stddev-sans-first:6118.49 18:10:04 INFO - PID 8882 | Values: 1373.5 1413.3 1434.8 1437.8 1446.1 14005.0 14602.9 14659.4 14668.1 15006.2 14750.6 14997.1 15026.4 15028.2 15052.8 2589.2 2677.3 2721.5 2730.5 2731.1 2731.2 2752.0 2766.1 2770.3 2774.7 2708.1 2713.6 2718.3 2739.4 2746.7 2662.3 2680.5 2691.6 2705.1 2730.3 2669.3 2675.3 2688.1 2688.5 2690.0 14051.2 14274.9 14448.2 14463.6 14476.9 7786.3 8112.7 8126.9 8146.3 8170.0 5201.4 5338.8 5392.4 5452.1 5456.4 1813.6 1820.2 1837.7 1858.2 1860.9 23860.6 24114.4 24173.9 24219.8 24266.4 6416.7 6596.4 6655.0 6804.0 6849.5 16442.1 16442.2 16474.8 16502.4 16544.7 7598.5 7752.7 7763.3 7769.0 7770.0 7081.3 7130.7 7232.2 7253.2 7284.6 5071.4 5215.2 5216.6 5229.0 5262.2 1419.8 1441.4 1446.4 1456.7 1467.8 883.1 910.6 917.6 927.5 928.8 7556.2 7655.5 7715.7 8578.0 8581.6 708.9 711.3 716.5 717.1 736.4 5041.3 5358.4 5417.6 5459.3 5512.4 19259.3 19847.2 20130.0 20160.9 20268.0 19009.2 19988.0 20203.8 20271.4 20311.1 10564.7 10865.5 10872.4 10876.1 10949.1 8459.3 8650.6 8721.9 8827.3 8936.1 16924.3 17252.7 17295.1 17446.6 17555.1 16453.8 16464.8 16496.4 16700.2 16781.2 11558.7 11816.8 11817.5 11823.1 11832.9 13354.3 13484.9 13570.3 13631.3 13707.4 11036.1 11090.5 11129.4 11324.4 11367.4 10912.1 11047.3 11088.8 11105.2 11168.1 9538.6 9667.5 9839.6 9847.3 9852.7 7160.1 7288.2 7311.4 7326.9 7422.5 7369.7 7413.1 7480.9 7532.5 7536.2 18:10:04 INFO - PID 8882 | 18:10:04 INFO - PID 8882 | [#4] prototype.html Cycles:180 Average:5644.24 Median:6164.43 stddev:1522.70 (24.7%) stddev-sans-first:1477.14 18:10:04 INFO - PID 8882 | Values: 496.4 498.1 514.4 522.5 529.6 6296.3 6316.2 6325.4 6338.1 6394.5 5930.7 6110.0 6132.4 6166.4 6195.2 4902.8 4948.9 4953.9 4980.4 5029.3 4920.2 4958.9 4966.3 5014.4 5080.8 5110.3 5160.4 5204.6 5234.7 5255.7 5172.3 5182.4 5215.8 5225.7 5243.4 4834.8 4862.5 4869.4 4889.1 4927.7 6083.2 6124.5 6153.7 6164.3 6164.6 5972.3 6066.9 6075.2 6111.0 6175.4 6574.6 6612.2 6616.6 6635.6 6654.3 5282.4 5344.1 5369.2 5370.5 5400.7 6937.6 6955.8 6976.5 7039.6 7100.9 5455.7 5478.8 5485.7 5512.4 5533.5 5577.0 5588.4 5601.7 5602.7 5621.2 5994.4 6033.9 6071.4 6100.4 6129.7 6613.7 6693.4 6752.2 6756.4 6760.6 1866.2 1923.5 1923.7 1959.9 1985.0 1446.7 1455.0 1455.6 1466.7 1474.4 5757.9 5763.9 5769.8 5803.2 5815.7 6571.3 6764.3 6765.6 6783.4 6848.7 5741.9 5771.0 5797.5 5815.4 5833.6 3564.3 3564.9 3578.7 3641.3 3652.7 6580.8 6599.4 6621.7 6647.2 6665.2 6900.4 6943.9 7006.9 7016.5 7076.4 6535.6 6542.9 6574.8 6607.0 6638.0 6676.8 6803.8 6803.9 6804.9 6916.4 6731.4 6754.4 6757.8 6792.8 6805.7 6566.5 6678.5 6683.2 6695.7 6708.8 4961.4 4986.6 5029.6 5031.0 5057.7 6801.3 6835.7 6836.9 6853.4 6884.3 6600.5 6600.6 6611.3 6615.5 6671.2 6519.2 6579.6 6592.7 6605.4 6631.9 6215.9 6226.7 6306.8 6390.3 6427.9 6462.7 6469.8 6503.0 6611.9 6633.3 6220.8 6238.1 6276.8 6354.1 6385.5 18:10:04 INFO - PID 8882 | 18:10:04 INFO - PID 8882 | [#5] yui.html Cycles:180 Average:24645.05 Median:19079.76 stddev:34140.45 (178.9%) stddev-sans-first:34189.71 18:10:04 INFO - PID 8882 | Values: 912.3 920.1 921.5 924.3 928.8 17166.7 17186.5 17230.7 17255.4 22472.2 17794.9 17859.9 17940.0 17946.9 17969.6 1023.9 1047.4 1060.1 1061.8 1064.9 1067.5 1069.1 1077.1 1077.1 1077.2 1105.5 1111.2 1120.4 1120.5 1120.8 1108.1 1109.6 1115.4 1115.9 1117.6 811.9 814.9 816.7 817.7 819.8 18528.4 18540.1 18541.4 20351.7 21018.5 21743.7 21942.5 22054.6 22199.8 22303.6 16707.2 16829.2 16982.1 17080.9 17176.8 3591.7 3617.9 3649.6 3650.5 3651.9 130188.3 131282.0 133524.3 133954.0 135505.6 16645.2 17148.1 17369.7 17465.2 17496.5 29769.4 31157.8 31652.2 31818.8 31830.2 8521.9 8642.7 8733.0 8776.1 8816.9 3745.6 3923.2 4175.9 4283.0 4298.7 6130.4 6286.2 6298.1 6303.3 6318.4 1095.6 1141.6 1150.7 1152.6 1164.6 675.4 688.1 689.0 694.9 702.6 12282.8 12382.8 12693.6 13396.6 13693.6 673.4 675.4 676.7 690.9 695.1 5660.0 5699.1 5822.9 5854.6 5861.4 113264.0 115584.0 116140.0 117306.0 121846.0 102718.0 104426.5 107142.0 107196.9 109794.0 87522.6 88752.6 89698.0 90085.1 91591.0 10837.0 10974.3 10992.4 11104.4 11280.2 39372.8 39491.4 40120.0 40980.0 42316.0 71912.6 73396.0 73907.6 75581.2 77775.2 19261.7 19369.5 19587.7 19791.3 19806.8 19324.8 19488.4 19501.9 19517.3 19646.9 18524.7 18569.6 18611.1 19069.7 19792.5 18771.2 19043.8 19089.8 19219.8 20212.2 18343.3 18737.8 18823.8 19276.3 20085.0 12107.2 12228.9 12419.7 12516.5 12825.8 13400.2 13799.1 13999.9 14049.9 14769.4 18:10:04 INFO - PID 8882 | -------- Summary: end -------- 18:10:04 INFO - PID 8882 | 18:10:05 INFO - TEST-INFO | 8882: exit 0 18:10:05 INFO - TEST-OK | dromaeo_css | took 1113091ms 18:10:05 INFO - TEST-START | kraken 18:10:05 INFO - Initialising browser for kraken test... 18:10:05 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:32974/getInfo.html -profile /tmp/tmpm3urp4/profile 18:10:05 INFO - TEST-INFO | started process 9254 (/builds/slave/test/build/application/firefox/firefox http://localhost:32974/getInfo.html) 18:10:11 INFO - TEST-INFO | 9254: exit 0 18:10:11 INFO - Browser initialized. 18:10:11 INFO - Running cycle 1/1 for kraken test... 18:10:11 INFO - TEST-INFO | started process 9447 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm3urp4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:10:12 INFO - PID 9447 | 18:10:12 INFO - PID 9447 | (/builds/slave/test/build/application/firefox/firefox:9502): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 18:10:12 INFO - PID 9447 | 18:10:22 INFO - PID 9447 | RSS: Main: 166793216 18:10:22 INFO - PID 9447 | 18:10:25 INFO - PID 9447 | Cycle 1(1): loaded http://localhost:32974/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:32974/tests/kraken/driver.html?testName=audio-beat-detection) 18:10:26 INFO - PID 9447 | RSS: Main: 173211648 18:10:26 INFO - PID 9447 | 18:10:29 INFO - PID 9447 | Cycle 1(1): loaded http://localhost:32974/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:32974/tests/kraken/driver.html?testName=audio-dft) 18:10:29 INFO - PID 9447 | RSS: Main: 177217536 18:10:29 INFO - PID 9447 | 18:10:32 INFO - PID 9447 | Cycle 1(1): loaded http://localhost:32974/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:32974/tests/kraken/driver.html?testName=audio-fft) 18:10:33 INFO - PID 9447 | RSS: Main: 170885120 18:10:33 INFO - PID 9447 | 18:10:35 INFO - PID 9447 | Cycle 1(1): loaded http://localhost:32974/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:32974/tests/kraken/driver.html?testName=audio-oscillator) 18:10:36 INFO - PID 9447 | RSS: Main: 171216896 18:10:36 INFO - PID 9447 | 18:10:38 INFO - PID 9447 | Cycle 1(1): loaded http://localhost:32974/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:32974/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:10:39 INFO - PID 9447 | RSS: Main: 171597824 18:10:39 INFO - PID 9447 | 18:10:42 INFO - PID 9447 | Cycle 1(1): loaded http://localhost:32974/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:32974/tests/kraken/driver.html?testName=imaging-darkroom) 18:10:42 INFO - PID 9447 | RSS: Main: 172675072 18:10:42 INFO - PID 9447 | 18:10:46 INFO - PID 9447 | Cycle 1(1): loaded http://localhost:32974/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:32974/tests/kraken/driver.html?testName=imaging-desaturate) 18:10:47 INFO - PID 9447 | RSS: Main: 172290048 18:10:47 INFO - PID 9447 | 18:10:49 INFO - PID 9447 | Cycle 1(1): loaded http://localhost:32974/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:32974/tests/kraken/driver.html?testName=json-parse-financial) 18:10:50 INFO - PID 9447 | RSS: Main: 173690880 18:10:50 INFO - PID 9447 | 18:10:52 INFO - PID 9447 | Cycle 1(1): loaded http://localhost:32974/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:32974/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:10:52 INFO - PID 9447 | RSS: Main: 173420544 18:10:52 INFO - PID 9447 | 18:10:54 INFO - PID 9447 | Cycle 1(1): loaded http://localhost:32974/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:32974/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:10:55 INFO - PID 9447 | RSS: Main: 173338624 18:10:55 INFO - PID 9447 | 18:10:57 INFO - PID 9447 | Cycle 1(1): loaded http://localhost:32974/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:32974/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:10:58 INFO - PID 9447 | RSS: Main: 173056000 18:10:58 INFO - PID 9447 | 18:11:00 INFO - PID 9447 | Cycle 1(1): loaded http://localhost:32974/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:32974/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:11:01 INFO - PID 9447 | RSS: Main: 173768704 18:11:01 INFO - PID 9447 | 18:11:04 INFO - PID 9447 | Cycle 1(1): loaded http://localhost:32974/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:32974/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:11:05 INFO - PID 9447 | RSS: Main: 173699072 18:11:05 INFO - PID 9447 | 18:11:07 INFO - PID 9447 | Cycle 1(1): loaded http://localhost:32974/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:32974/tests/kraken/driver.html?testName=ai-astar) 18:11:07 INFO - PID 9447 | RSS: Main: 175464448 18:11:07 INFO - PID 9447 | 18:11:07 INFO - PID 9447 | __start_tp_report 18:11:07 INFO - PID 9447 | _x_x_mozilla_page_load 18:11:07 INFO - PID 9447 | _x_x_mozilla_page_load_details 18:11:07 INFO - PID 9447 | |i|pagename|runs| 18:11:07 INFO - PID 9447 | |0;ai-astar;98;107;100;108;108;117;109;102;108;113 18:11:07 INFO - PID 9447 | |1;audio-beat-detection;147;118;144;171;117;140;147;118;175;117 18:11:07 INFO - PID 9447 | |2;audio-dft;163;162;162;165;165;162;167;172;163;164 18:11:07 INFO - PID 9447 | |3;audio-fft;78;78;74;177;83;75;73;88;96;76 18:11:07 INFO - PID 9447 | |4;audio-oscillator;81;82;140;82;78;86;125;79;77;121 18:11:07 INFO - PID 9447 | |5;imaging-gaussian-blur;113;119;113;114;114;115;114;114;116;115 18:11:07 INFO - PID 9447 | |6;imaging-darkroom;150;157;152;150;149;150;151;149;152;151 18:11:07 INFO - PID 9447 | |7;imaging-desaturate;94;94;94;97;93;93;95;93;94;93 18:11:07 INFO - PID 9447 | |8;json-parse-financial;53;57;60;53;53;53;62;53;53;59 18:11:07 INFO - PID 9447 | |9;json-stringify-tinderbox;59;60;58;58;54;53;59;54;54;58 18:11:07 INFO - PID 9447 | |10;stanford-crypto-aes;77;79;79;88;78;75;76;75;76;76 18:11:07 INFO - PID 9447 | |11;stanford-crypto-ccm;119;129;120;127;117;121;131;127;119;157 18:11:07 INFO - PID 9447 | |12;stanford-crypto-pbkdf2;178;177;174;185;176;180;177;175;171;180 18:11:07 INFO - PID 9447 | |13;stanford-crypto-sha256-iterative;72;74;70;67;72;66;67;72;68;66 18:11:07 INFO - PID 9447 | __end_tp_report 18:11:07 INFO - PID 9447 | __start_cc_report 18:11:07 INFO - PID 9447 | _x_x_mozilla_cycle_collect,959 18:11:07 INFO - PID 9447 | __end_cc_report 18:11:07 INFO - PID 9447 | __startTimestamp1502932267328__endTimestamp 18:11:07 INFO - PID 9447 | 18:11:07 INFO - PID 9447 | ------- Summary: start ------- 18:11:07 INFO - PID 9447 | Number of tests: 14 18:11:07 INFO - PID 9447 | 18:11:07 INFO - PID 9447 | [#0] ai-astar Cycles:10 Average:107.00 Median:108.50 stddev:5.75 (5.3%) stddev-sans-first:5.10 18:11:07 INFO - PID 9447 | Values: 98.0 107.0 100.0 108.0 108.0 117.0 109.0 102.0 108.0 113.0 18:11:07 INFO - PID 9447 | 18:11:07 INFO - PID 9447 | [#1] audio-beat-detection Cycles:10 Average:139.40 Median:145.50 stddev:21.91 (15.1%) stddev-sans-first:23.07 18:11:07 INFO - PID 9447 | Values: 147.0 118.0 144.0 171.0 117.0 140.0 147.0 118.0 175.0 117.0 18:11:07 INFO - PID 9447 | 18:11:07 INFO - PID 9447 | [#2] audio-dft Cycles:10 Average:164.50 Median:164.50 stddev:3.10 (1.9%) stddev-sans-first:3.24 18:11:07 INFO - PID 9447 | Values: 163.0 162.0 162.0 165.0 165.0 162.0 167.0 172.0 163.0 164.0 18:11:07 INFO - PID 9447 | 18:11:07 INFO - PID 9447 | [#3] audio-fft Cycles:10 Average:89.80 Median:78.00 stddev:31.47 (40.3%) stddev-sans-first:33.08 18:11:07 INFO - PID 9447 | Values: 78.0 78.0 74.0 177.0 83.0 75.0 73.0 88.0 96.0 76.0 18:11:07 INFO - PID 9447 | 18:11:07 INFO - PID 9447 | [#4] audio-oscillator Cycles:10 Average:95.10 Median:80.00 stddev:23.77 (29.7%) stddev-sans-first:24.66 18:11:07 INFO - PID 9447 | Values: 81.0 82.0 140.0 82.0 78.0 86.0 125.0 79.0 77.0 121.0 18:11:07 INFO - PID 9447 | 18:11:07 INFO - PID 9447 | [#5] imaging-gaussian-blur Cycles:10 Average:114.70 Median:114.50 stddev:1.77 (1.5%) stddev-sans-first:1.76 18:11:07 INFO - PID 9447 | Values: 113.0 119.0 113.0 114.0 114.0 115.0 114.0 114.0 116.0 115.0 18:11:07 INFO - PID 9447 | 18:11:07 INFO - PID 9447 | [#6] imaging-darkroom Cycles:10 Average:151.10 Median:151.00 stddev:2.33 (1.5%) stddev-sans-first:2.44 18:11:07 INFO - PID 9447 | Values: 150.0 157.0 152.0 150.0 149.0 150.0 151.0 149.0 152.0 151.0 18:11:07 INFO - PID 9447 | 18:11:07 INFO - PID 9447 | [#7] imaging-desaturate Cycles:10 Average:94.00 Median:94.00 stddev:1.25 (1.3%) stddev-sans-first:1.32 18:11:07 INFO - PID 9447 | Values: 94.0 94.0 94.0 97.0 93.0 93.0 95.0 93.0 94.0 93.0 18:11:07 INFO - PID 9447 | 18:11:07 INFO - PID 9447 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:55.00 stddev:3.57 (6.5%) stddev-sans-first:3.66 18:11:07 INFO - PID 9447 | Values: 53.0 57.0 60.0 53.0 53.0 53.0 62.0 53.0 53.0 59.0 18:11:07 INFO - PID 9447 | 18:11:07 INFO - PID 9447 | [#9] json-stringify-tinderbox Cycles:10 Average:56.70 Median:58.00 stddev:2.63 (4.5%) stddev-sans-first:2.65 18:11:07 INFO - PID 9447 | Values: 59.0 60.0 58.0 58.0 54.0 53.0 59.0 54.0 54.0 58.0 18:11:07 INFO - PID 9447 | 18:11:07 INFO - PID 9447 | [#10] stanford-crypto-aes Cycles:10 Average:77.90 Median:77.50 stddev:3.84 (5.0%) stddev-sans-first:4.06 18:11:07 INFO - PID 9447 | Values: 77.0 79.0 79.0 88.0 78.0 75.0 76.0 75.0 76.0 76.0 18:11:07 INFO - PID 9447 | 18:11:07 INFO - PID 9447 | [#11] stanford-crypto-ccm Cycles:10 Average:126.70 Median:127.00 stddev:11.70 (9.2%) stddev-sans-first:12.07 18:11:07 INFO - PID 9447 | Values: 119.0 129.0 120.0 127.0 117.0 121.0 131.0 127.0 119.0 157.0 18:11:07 INFO - PID 9447 | 18:11:07 INFO - PID 9447 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.30 Median:177.50 stddev:3.83 (2.2%) stddev-sans-first:4.06 18:11:07 INFO - PID 9447 | Values: 178.0 177.0 174.0 185.0 176.0 180.0 177.0 175.0 171.0 180.0 18:11:07 INFO - PID 9447 | 18:11:07 INFO - PID 9447 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.40 Median:71.00 stddev:2.95 (4.2%) stddev-sans-first:2.98 18:11:07 INFO - PID 9447 | Values: 72.0 74.0 70.0 67.0 72.0 66.0 67.0 72.0 68.0 66.0 18:11:07 INFO - PID 9447 | -------- Summary: end -------- 18:11:07 INFO - PID 9447 | 18:11:07 INFO - PID 9447 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 18:11:07 INFO - TEST-INFO | 9447: exit 0 18:11:08 INFO - TEST-OK | kraken | took 63000ms 18:11:08 INFO - SUITE-END | took 1176s 18:11:08 INFO - Completed test suite (00:19:36) 18:11:08 INFO - javascript benchmark 18:11:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8673.236535968503, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3157.368526294741, 3165.1928758166678, 3194.488881778913, 3210.566573512576, 3229.9677003229963, 6272.059191121334, 6351.396617321353, 6374.490040796737, 6384.201974753156, 6406.007068904316, 6151.81544553663, 6223.502119830414, 6243.125962365261, 6261.998080307152, 6262.749490020405, 5752.511036561887, 5767.538596912237, 5800.071988481844, 5803.448672376117, 5825.038868586678, 5791.189233507313, 5791.681457519835, 5801.709914504279, 5821.970890145543, 5838.503727183194, 5872.324682661484, 5883.646981181143, 5910.822675319747, 5951.107333899907, 5997.310309314419, 5726.3414707308775, 5781.855453613652, 5812.709364531799, 5830.475257226849, 5864.76540938362, 5381.0, 5582.91625625616, 5741.081426971707, 5755.68343741094, 5780.0751879699465, 6068.241469816273, 6172.660503672296, 6221.9377806222265, 6273.811785646438, 6309.810705678837, 6706.362895524917, 6725.562838415487, 6810.9318906810795, 6814.863702725917, 6831.11195544581, 6718.05947167397, 6782.253952065318, 6810.0, 6812.795616131524, 6887.173539175281, 6287.088372186007, 6296.150019747367, 6322.304546499881, 6325.209348831396, 6332.145160403379, 6934.826629334307, 6947.756828510978, 7028.859422811515, 7045.084139061889, 7074.186468556079, 6603.7358505660195, 6649.0, 6657.40083392497, 6743.291954344723, 6756.290589488033, 6630.7679231226675, 6755.290694477009, 6798.286179951133, 6893.379595836399, 6895.793126206222, 6668.199816022108, 6690.464762818963, 6727.730890764315, 6767.796966091025, 6783.93216067833, 6730.32696730323, 6791.456683465311, 6814.1482314710665, 6823.078884350549, 6852.897206541906, 5403.297571315782, 5408.215808707715, 5464.9180262296095, 5483.945160548344, 5487.259220005328, 4616.584507394351, 4628.652851036186, 4689.812407503729, 4712.6229901607785, 4722.220833562424, 5733.799317023884, 5767.596268261265, 5818.156367326714, 5829.650220986754, 5848.0350742127075, 6839.829004274933, 6883.7590684325805, 6894.103766510422, 6899.724011039602, 6920.792376228721, 5683.920055189501, 5766.365699773021, 5837.854053648608, 5846.210761547137, 5850.64896106235, 5778.248827652463, 5893.499052580493, 5894.086416605433, 5896.174535565025, 5912.940870591325, 6498.967505162444, 6510.674466276667, 6517.837054073686, 6519.706613202417, 6520.0871877937125, 6713.160854893138, 6759.188897332155, 6838.0084887692, 6875.278095799869, 6884.48366372514, 6599.8020059398295, 6691.799246022432, 6703.564268322543, 6705.564138331188, 6708.563943343667, 6659.134312539532, 6708.396244338033, 6715.3620406061345, 6815.045893574805, 6819.079424277659, 6667.299933507106, 6744.0, 6754.054432379373, 6757.729690812313, 6895.034695142785, 6578.638174900427, 6588.8023359299295, 6621.370969757865, 6621.834454138492, 6625.635590042594, 6541.803745887631, 6544.312847150981, 6544.9672751635935, 6579.4736421087155, 6581.407673309425, 6469.094326794158, 6505.381988711065, 6507.186601674791, 6585.539012269287, 6612.933870661232, 6506.284308725942, 6538.117354157128, 6569.4744420447205, 6657.334266573498, 6685.8328541784895, 6382.457491113121, 6400.839979000562, 6405.647689377129, 6423.8394040147505, 6428.485721142204], "value": 6172.570630282385, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [737.8561180569791, 802.7070119406417, 827.329862811123, 831.1356189562855, 1157.2824848593862, 29757.40485190295, 40798.79600601996, 41471.0, 41523.96190095253, 41631.583684163226, 41370.37944430836, 41534.16931661365, 41688.37467437983, 41756.79121604388, 41773.58226417735, 7138.678759455837, 7551.773446796591, 7704.229577042307, 7704.653290601908, 7751.418643601724, 7513.849723005536, 7581.507202031878, 7611.200823913492, 7617.162112167657, 7638.045244344457, 7639.770806875803, 7648.120466146409, 7690.6154692265445, 7695.192004839495, 7703.037120359955, 7594.278543538355, 7597.164311925684, 7637.121731000895, 7644.0, 7663.386929045663, 7494.325510704009, 7516.436267279976, 7518.962405187994, 7557.886631700529, 7564.243575642447, 37427.25145497075, 37475.62524374748, 37537.0, 37579.81210093959, 37587.0, 3438.6561343865415, 3490.2495963367996, 3494.4583589543663, 3508.15804206991, 3509.2630547585036, 30506.38987220243, 30527.389452211053, 30645.846770766002, 30648.2337941551, 30679.693203067905, 4838.6371022173125, 5040.722760248185, 5045.0, 5072.492750724935, 5087.287779710843, 192248.0, 193992.0, 194720.0, 194786.0, 194930.0, 47237.763811180725, 47262.400567968405, 47276.0, 47328.0, 47334.28998565024, 47874.521254787, 48091.27863082057, 48128.27807582889, 48169.75915120472, 48275.517244827104, 13424.127431716906, 16032.519024429286, 16224.513264602081, 16230.51308460748, 16244.51266462008, 11053.778924421467, 13318.600441986757, 13358.666033349244, 13359.73280534384, 13440.798388024188, 13679.86320136786, 13773.793393099111, 13950.930245348709, 14000.369983350774, 14074.788878166835, 5612.522935550524, 5620.634658747168, 5668.149777533321, 5723.814944629137, 5732.484076433057, 987.2546227598261, 999.1307562420741, 1021.2544842265039, 1033.3593172233113, 1038.2109596706407, 22723.43360337418, 22922.65616015761, 22955.655665165035, 23159.652605210937, 23247.3025809226, 1097.7969075721016, 1098.1489345756943, 1115.2472081345059, 1116.4975760907623, 1122.0742887117997, 12030.4586293617, 15938.28277727505, 15970.76043859343, 16418.26117824701, 16446.588835278973, 241750.0, 241886.0, 241952.0, 243416.0, 244024.0, 56165.438345616836, 56408.71795641078, 56842.715786420806, 56974.715126424104, 57272.0, 1445.4579532675248, 1446.833614134388, 1487.7991471151256, 1489.2181604657642, 1495.8803295736316, 27149.1855244343, 27665.58501622437, 27689.169324920284, 27710.307242318297, 27792.305192369542, 50309.74845125751, 50800.0, 50847.0, 50991.49008510016, 51036.48963510317, 212577.0, 213296.0, 213725.0, 215412.0, 215516.0, 34879.302413951074, 37216.0, 37877.81061094787, 37956.430653540774, 37999.43000854934, 44942.77528612336, 45320.773396132805, 45333.09333813371, 45780.31329530126, 45788.54211457843, 34114.82942585271, 34213.144671383416, 34461.310773784884, 34505.0, 34573.0, 33568.16079598029, 33594.0, 33608.0, 33723.0, 34263.143421414665, 37068.0, 37279.06802329963, 37522.624773751915, 37535.0, 37630.811845940596, 32200.0, 32738.836305818317, 32857.17857053593, 33085.0, 33302.0, 24019.0, 24765.0, 24813.87593062023, 25149.74850251547, 25244.368890777143], "value": 17631.607049485803, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.6860373888752, 562.4038519169678, 569.9544036477082, 584.2054805464569, 584.4944123333316, 21330.89334553327, 22049.779502204972, 22152.113915443384, 22185.334439966806, 22703.20538781143, 26072.47855042898, 26654.0, 26705.732942670616, 26718.732812671868, 26753.464930701375, 6049.153118563416, 6139.969300153493, 6185.072239164139, 6186.536009799261, 6186.876262474748, 5777.537796976232, 6018.548608854353, 6269.749210031593, 6275.529335299848, 6289.559730818844, 6270.278917924428, 6272.68636568172, 6275.780347687832, 6279.309275979638, 6281.43467087962, 6236.18929539157, 6237.875242495147, 6250.562460627758, 6261.96869015652, 6266.342034086424, 5774.855628609276, 5777.682227477487, 5845.152452894349, 5858.209141765849, 5859.882802343972, 28312.71687283142, 28813.135605931646, 29395.853020734972, 29871.253218669706, 30121.246968825737, 1959.804019598043, 1999.8400127989726, 2012.537116463207, 2016.395081475566, 2025.382258411184, 18506.44480665582, 19111.90444047771, 19145.234190632356, 19203.61592768151, 19214.0, 2385.666006759055, 2423.9878800605884, 2476.950460990788, 2481.8759062046825, 2485.987570062156, 130711.0, 134194.0, 134355.0, 134448.0, 134493.0, 14217.92891035559, 14777.778333325008, 15052.247387630574, 15119.773203401957, 15542.5337239883, 23248.65127023096, 23748.64377034346, 23759.1684291049, 23779.0, 23829.642555361683, 10525.789484210427, 10663.946680266548, 10723.356598604109, 10725.678229653124, 10852.620158294421, 8283.337333013344, 9915.454649994319, 9923.801523969625, 9950.0, 10076.0, 8304.958475207586, 9290.210332121846, 9456.0, 9464.19554337889, 9562.235021198287, 2720.9865448463356, 2743.1359121876544, 2767.557190849495, 2772.542530482488, 2883.740463358308, 939.6288466056006, 969.1713584884963, 978.6427953796813, 986.6250824686573, 993.5876611206269, 19976.60046799056, 20184.89907550482, 20308.883011434515, 20413.16281534669, 20438.59122817535, 1029.45953374479, 1051.3218973762034, 1053.489057806963, 1054.9894501054891, 1064.8455973883742, 11241.494132764044, 11344.0, 11412.201145919706, 11451.713707157387, 11477.483513241925, 453428.0, 459424.0, 465823.0, 470553.0, 491183.0, 114519.42740286412, 115771.0, 117463.41268293603, 117688.0, 118605.4069729663, 1171.6777886081225, 1173.700706319883, 1209.0992210802833, 1209.631062525938, 1212.0606529939191, 17655.823441765417, 17725.650687495116, 18125.27498900082, 18203.816751911083, 18452.0, 53835.461645383046, 54512.45487545233, 55596.0, 65100.674496627216, 66873.33126668671, 81255.0, 81301.59349203216, 82096.0, 84875.5756221215, 85856.14143858482, 16853.91573042176, 21679.0, 22328.330150095524, 22652.433689157904, 22963.0, 23058.654120188545, 23977.640335394633, 24585.262442126765, 24604.261872143863, 24831.87584062068, 17990.0, 18674.439766807016, 18674.439766807016, 18680.7197892029, 18684.159212835184, 17444.127793610016, 17502.0, 17516.737248941532, 18322.450326490227, 18327.541811454288, 18300.72548911794, 18882.811171888105, 18985.335513257523, 19060.428187154408, 19300.517487062934, 21586.460338491663, 21965.23121690733, 22049.0, 22079.779202208414, 22318.330450086523, 18620.813791861907, 19143.521411964255, 19343.613127737084, 19477.123529440927, 19484.1232144551], "value": 12322.866104055352, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1373.5124030969005, 1413.265102146883, 1434.8278206615207, 1437.7915202295667, 1446.1034158821528, 14005.0, 14602.926985365071, 14659.41362345505, 14668.11991280524, 15006.174660393674, 14750.631234219123, 14997.10017398957, 15026.398944042225, 15028.173450460221, 15052.849471505282, 2589.223233030093, 2677.263752468067, 2721.4965231432247, 2730.5085084684747, 2731.112388473744, 2731.2489065506948, 2751.9587206191923, 2766.14249582629, 2770.252031951372, 2774.667039955208, 2708.0927889157156, 2713.592961055838, 2718.2796558911905, 2739.369944912671, 2746.7115952824965, 2662.267876334004, 2680.5041067402594, 2691.636629055082, 2705.0937935791535, 2730.30377253799, 2669.279294590469, 2675.331167208198, 2688.086050742757, 2688.502627014009, 2689.99125328002, 14051.156930584199, 14274.857251427457, 14448.205348705817, 14463.566093017227, 14476.855231447656, 7786.299233068994, 8112.675492980274, 8126.878096828552, 8146.266835984789, 8170.0, 5201.427842937273, 5338.786448542053, 5392.4337944515655, 5452.1276595744885, 5456.399796022434, 1813.564744461333, 1820.1718218210815, 1837.6692195404821, 1858.1731129647312, 1860.8697391182623, 23860.64209036866, 24114.39714007146, 24173.87913060441, 24219.757802422104, 24266.39334016646, 6416.679166041679, 6596.4393026592315, 6655.0, 6803.965980170067, 6849.486288528281, 16442.095684737214, 16442.177891105635, 16474.83525164757, 16502.42241521541, 16544.6691066178, 7598.468107232551, 7752.6898924043535, 7763.301302882654, 7768.961155194188, 7769.961150194326, 7081.256468070881, 7130.714771409189, 7232.20445750967, 7253.202147763742, 7284.635768211569, 5071.366079240095, 5215.16557350822, 5216.556592689664, 5229.032628963654, 5262.158054711228, 1419.822522184727, 1441.3730027438098, 1446.378057435313, 1456.6940942402214, 1467.8385377608454, 883.1212943121507, 910.6266430763355, 917.6467060181878, 927.4945154890601, 928.8049509602924, 7556.2443755624, 7655.540667559964, 7715.652795624211, 8577.957110214535, 8581.613827377783, 708.9334589671051, 711.2851584157888, 716.5127713155, 717.1394326807851, 736.37408203027, 5041.269015992661, 5358.356997160366, 5417.59368047398, 5459.262999495097, 5512.448755124456, 19259.32592359289, 19847.20611175566, 20130.0, 20160.899195503927, 20268.0, 19009.239630414904, 19988.0, 20203.79796202019, 20271.391858244275, 20311.086001129985, 10564.735881602868, 10865.51105200268, 10872.402017888933, 10876.129909607054, 10949.069329106957, 8459.323254139777, 8650.567471626267, 8721.912780872364, 8827.293816494794, 8936.106389361012, 16924.32302707878, 17252.65494690074, 17295.135243237535, 17446.563835903697, 17555.122243887497, 16453.83546164523, 16464.753028704818, 16496.42262520806, 16700.248488818277, 16781.244843981807, 11558.653240402802, 11816.822747658964, 11817.468213930222, 11823.113266504875, 11832.940835295769, 13354.332283385986, 13484.932575337061, 13570.253636050113, 13631.250281234627, 13707.383167757675, 11036.11711063129, 11090.500927458123, 11129.387883666475, 11324.433778310886, 11367.431628418712, 10912.127029837435, 11047.337159770439, 11088.778224435628, 11105.222634415513, 11168.1065514757, 9538.618455261712, 9667.468289243878, 9839.557219924978, 9847.31068825204, 9852.655157069468, 7160.069191005136, 7288.198298187089, 7311.3785328247695, 7326.853462930818, 7422.480426370318, 7369.742059027908, 7413.147488038944, 7480.925190748023, 7532.472726909064, 7536.208698086622], "value": 6499.400187569357, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [496.3621746056316, 498.0767334056615, 514.4264145477794, 522.5245027025408, 529.5710474515643, 6296.338884417139, 6316.242050953886, 6325.36291632311, 6338.144350512679, 6394.456471199954, 5930.703464826752, 6109.969450152743, 6132.417420345071, 6166.414190651881, 6195.2255968004, 4902.828401005965, 4948.901021979558, 4953.851384458472, 4980.389217817072, 5029.321041659366, 4920.23736320869, 4958.925616115761, 4966.329545511346, 5014.398272207341, 5080.77136528857, 5110.28456016158, 5160.406553246368, 5204.635675502716, 5234.7120908350025, 5255.710935898524, 5172.32759741235, 5182.408795602199, 5215.817446389377, 5225.686458812445, 5243.397009343936, 4834.758262086917, 4862.465128835825, 4869.440014398354, 4889.071076495455, 4927.704337739747, 6083.209182806207, 6124.540659450559, 6153.692315384213, 6164.260288765377, 6164.5923164937285, 5972.25346831646, 6066.939330606681, 6075.179850720185, 6111.0, 6175.4442100210745, 6574.572652777602, 6612.173478315211, 6616.636085015322, 6635.568688035262, 6654.301298363651, 5282.3624676350455, 5344.118220493614, 5369.221462887859, 5370.5435038021815, 5400.702961337125, 6937.618430986294, 6955.826104347432, 6976.5116441849095, 7039.627272681829, 7100.92899071013, 5455.745178608863, 5478.780848766005, 5485.670859748428, 5512.448755124536, 5533.474319939599, 5577.0, 5588.385277619459, 5601.719914004283, 5602.747876345574, 5621.161313536638, 5994.422398368743, 6033.939660603338, 6071.392860713893, 6100.359462256488, 6129.662868542273, 6613.702383392759, 6693.364130407604, 6752.155980502437, 6756.425703815133, 6760.628165450948, 1866.1788812922541, 1923.538350795799, 1923.7114432835187, 1959.8530110241788, 1985.0, 1446.7395868743727, 1455.0, 1455.5778824141091, 1466.7286551987916, 1474.370820243637, 5757.913631295534, 5763.9135412968, 5769.798057067983, 5803.187553742479, 5815.651060936273, 6571.310012448624, 6764.347252483603, 6765.594064356154, 6783.3555812197765, 6848.657567121723, 5741.85645358861, 5770.971145144247, 5797.4782269595935, 5815.389384114692, 5833.620814647034, 3564.3049605327233, 3564.8574057037945, 3578.6958108561066, 3641.253543023674, 3652.6529979652423, 6580.80257592273, 6599.373059559334, 6621.735130594819, 6647.235567909753, 6665.200175978816, 6900.413464855443, 6943.89584156238, 7006.894896576556, 7016.473764467685, 7076.363127318566, 6535.581834721183, 6542.887709089371, 6574.76988305407, 6607.0, 6637.966810165918, 6676.83307917306, 6803.795886123424, 6803.877360235506, 6804.897926531007, 6916.446684265347, 6731.360520750521, 6754.392104710403, 6757.831054223684, 6792.762253321308, 6805.659717014229, 6566.474682025331, 6678.465722742072, 6683.198016238082, 6695.698693558899, 6708.798736037927, 4961.404631444249, 4986.626003049713, 5029.572486338702, 5031.0, 5057.721825299644, 6801.2858649841055, 6835.692393842389, 6836.863262734618, 6853.383195512428, 6884.311568843075, 6600.504962127956, 6600.60396376219, 6611.2727599963, 6615.470762338905, 6671.166104236971, 6519.217693876765, 6579.605223686594, 6592.736290548324, 6605.405513503808, 6631.933680663325, 6215.9378406217165, 6226.657533835682, 6306.779262725782, 6390.297067322498, 6427.907255766438, 6462.705739462611, 6469.77355792545, 6502.967485162544, 6611.900821487586, 6633.303503132294, 6220.844478888064, 6238.126662267196, 6276.843078923063, 6354.110424540476, 6385.457236134795], "value": 5206.8041769316105, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [912.2610685344871, 920.0891117793384, 921.4517362169511, 924.2790623313817, 928.8142371525695, 17166.65666686667, 17186.484405467825, 17230.655386892286, 17255.396061137864, 22472.213472528463, 17794.911025444853, 17859.91070044648, 17940.0, 17946.910265448656, 17969.64060718788, 1023.918086553074, 1047.350642601588, 1060.1148041385413, 1061.8035663402256, 1064.882862885082, 1067.4716015572303, 1069.1126365116934, 1077.0629552289479, 1077.1060020183268, 1077.154433769491, 1105.4748994227718, 1111.183280288987, 1120.38938778366, 1120.4789772755666, 1120.8094623913955, 1108.141190577301, 1109.6282745280341, 1115.3865374044283, 1115.8660960684688, 1117.5976648406568, 811.8579248631465, 814.9103598604149, 816.7182322098867, 817.7301490508119, 819.8442295963748, 18528.3515076973, 18540.07299635013, 18541.35105271309, 20351.69472457914, 21018.474538136517, 21743.67384489234, 21942.451438714, 22054.558908821895, 22199.778002219933, 22303.553928921494, 16707.164641767984, 16829.158542072848, 16982.065986370744, 17080.914595427068, 17176.82823171765, 3591.6947059499976, 3617.9095522612147, 3649.6350364963555, 3650.4889315495852, 3651.908702282438, 130188.3490582541, 131282.0, 133524.33237833847, 133954.0, 135505.6449435503, 16645.16774161287, 17148.142592870307, 17369.7394539082, 17465.21406536709, 17496.47510574685, 29769.40461190764, 31157.8442107788, 31652.208694782814, 31818.84090579532, 31830.2042448936, 8521.914780852236, 8642.697505587274, 8733.0, 8776.078511756301, 8816.911830881609, 3745.569259535134, 3923.1761330120426, 4175.874723758292, 4283.0, 4298.742075475481, 6130.356312587203, 6286.182796236551, 6298.086777417248, 6303.3066362700065, 6318.399752023551, 1095.6329629574022, 1141.5833220874488, 1150.7238262816863, 1152.5793085523892, 1164.6447833410891, 675.3887731602907, 688.0607970120749, 688.9758858439931, 694.9131358580178, 702.596007295807, 12282.815757763641, 12382.81425778614, 12693.619191424272, 13396.598102056954, 13693.589192324247, 673.4477728262777, 675.3651567526509, 676.7191615479619, 690.927452617478, 695.0755495191485, 5659.971700141556, 5699.116636921284, 5822.854428639318, 5854.619449735754, 5861.413858614104, 113264.0, 115584.0, 116140.0, 117306.0, 121846.0, 102718.0, 104426.47786761017, 107142.0, 107196.91304477955, 109794.0, 87522.56238718766, 88752.5562372184, 89698.0, 90085.09914900898, 91591.0, 10837.0, 10974.341539507655, 10992.395418252074, 11104.389258590854, 11280.210385272952, 39372.80313598413, 39491.40762888616, 40120.0, 40980.0, 42316.0, 71912.64043679748, 73396.0, 73907.63046184949, 75581.24418755741, 77775.2222477768, 19261.711074334176, 19369.547283953478, 19587.70618440696, 19791.30730424428, 19806.801931981074, 19324.8067519323, 19488.415347539598, 19501.902490487457, 19517.316893908646, 19646.901765491082, 18524.722129167803, 18569.628607428047, 18611.06944652735, 19069.713954290975, 19792.505187370432, 18771.15529801135, 19043.809561904756, 19089.809101908802, 19219.8078019218, 20212.19151233993, 18343.26626934908, 18737.812621873607, 18823.811761882753, 19276.32532861343, 20085.0, 12107.152499324962, 12228.938855306022, 12419.689507762378, 12516.499340026661, 12825.807612885628, 13400.195988240737, 13799.103058301178, 13999.930000349934, 14049.859501405264, 14769.409223630935], "value": 9378.785409359713, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1519.2000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 107.0, 100.0, 108.0, 108.0, 117.0, 109.0, 102.0, 108.0, 113.0], "value": 107.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 118.0, 144.0, 171.0, 117.0, 140.0, 147.0, 118.0, 175.0, 117.0], "value": 139.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 162.0, 165.0, 165.0, 162.0, 167.0, 172.0, 163.0, 164.0], "value": 164.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 74.0, 177.0, 83.0, 75.0, 73.0, 88.0, 96.0, 76.0], "value": 89.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 140.0, 82.0, 78.0, 86.0, 125.0, 79.0, 77.0, 121.0], "value": 95.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 119.0, 113.0, 114.0, 114.0, 115.0, 114.0, 114.0, 116.0, 115.0], "value": 114.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 157.0, 152.0, 150.0, 149.0, 150.0, 151.0, 149.0, 152.0, 151.0], "value": 151.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 97.0, 93.0, 93.0, 95.0, 93.0, 94.0, 93.0], "value": 94.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 57.0, 60.0, 53.0, 53.0, 53.0, 62.0, 53.0, 53.0, 59.0], "value": 55.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 58.0, 58.0, 54.0, 53.0, 59.0, 54.0, 54.0, 58.0], "value": 56.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 79.0, 79.0, 88.0, 78.0, 75.0, 76.0, 75.0, 76.0, 76.0], "value": 77.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 129.0, 120.0, 127.0, 117.0, 121.0, 131.0, 127.0, 119.0, 157.0], "value": 126.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 177.0, 174.0, 185.0, 176.0, 180.0, 177.0, 175.0, 171.0, 180.0], "value": 177.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 74.0, 70.0, 67.0, 72.0, 66.0, 67.0, 72.0, 68.0, 66.0], "value": 69.4, "unit": "score"}]}]} 18:11:08 INFO - Return code: 0 18:11:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:11:08 INFO - # TBPL SUCCESS # 18:11:08 INFO - Running post-action listener: _package_coverage_data 18:11:08 INFO - Running post-action listener: _resource_record_post_action 18:11:08 INFO - [mozharness: 2017-08-17 01:11:08.617212Z] Finished run-tests step (success) 18:11:08 INFO - Running post-run listener: _resource_record_post_run 18:11:08 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 622592; Write bytes: 430559232; Read time: 164; Write time: 322552 18:11:08 INFO - TinderboxPrint: CPU usage
13.1% 18:11:08 INFO - TinderboxPrint: I/O read bytes / time
622,592 / 164 18:11:08 INFO - TinderboxPrint: I/O write bytes / time
430,559,232 / 322,552 18:11:08 INFO - TinderboxPrint: CPU idle
8,274.5 (86.8%) 18:11:08 INFO - TinderboxPrint: CPU user
1,201.4 (12.6%) 18:11:08 INFO - TinderboxPrint: Swap in / out
0 / 0 18:11:08 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 106569728; Read time: 0; Write time: 101568 18:11:08 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 18:11:08 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 618496; Write bytes: 322867200; Read time: 156; Write time: 220908 18:11:09 INFO - Running post-run listener: _upload_blobber_files 18:11:09 INFO - Blob upload gear active. 18:11:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:11:09 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 18:11:09 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'] 18:11:09 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 18:11:09 INFO - (blobuploader) - INFO - Open directory for files ... 18:11:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:11:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:11:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:11:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:11:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:11:10 INFO - (blobuploader) - INFO - Done attempting. 18:11:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:11:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:11:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:11:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:11:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:11:11 INFO - (blobuploader) - INFO - Done attempting. 18:11:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:11:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:11:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:11:12 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:11:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:11:12 INFO - (blobuploader) - INFO - Done attempting. 18:11:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:11:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:11:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:11:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:11:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:11:19 INFO - (blobuploader) - INFO - Done attempting. 18:11:19 INFO - (blobuploader) - INFO - Iteration through files over. 18:11:19 INFO - Return code: 0 18:11:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:11:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:11:19 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d0c36c109dc8533dc7f116faaf3e9ba36ce97d243e39c63fb29bd5460c061320efb68b61413fa09bc29a1809d3fba26d823965e12e9b7ba296e5460a1ab059b0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6afe97b546826c99c8b84f8f945d802bbc54aaa929448e0ab9e59e489452b83088e8dadbb03bf45509bf26b6d72feb2da241aafe45b10b84d959bc529e74860e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2aad995b0c5049b0f81c11914bbb3403873bc850db938519b715508c154fe1ce580e0129be5ef8212d2e39634794af04bd3cd7adc59cbd9108a9e65d8d2531bb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c5cd309f0cd0958125aeedfb7b59a702073e175a5470ee946ff9ea014a0a5aa3fb35479b7f8e7ad49617f8f2cf6ccc97cd7a45b82451ca7cb6aad892ba2f222a"} 18:11:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:11:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:11:19 INFO - Contents: 18:11:19 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d0c36c109dc8533dc7f116faaf3e9ba36ce97d243e39c63fb29bd5460c061320efb68b61413fa09bc29a1809d3fba26d823965e12e9b7ba296e5460a1ab059b0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6afe97b546826c99c8b84f8f945d802bbc54aaa929448e0ab9e59e489452b83088e8dadbb03bf45509bf26b6d72feb2da241aafe45b10b84d959bc529e74860e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2aad995b0c5049b0f81c11914bbb3403873bc850db938519b715508c154fe1ce580e0129be5ef8212d2e39634794af04bd3cd7adc59cbd9108a9e65d8d2531bb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c5cd309f0cd0958125aeedfb7b59a702073e175a5470ee946ff9ea014a0a5aa3fb35479b7f8e7ad49617f8f2cf6ccc97cd7a45b82451ca7cb6aad892ba2f222a"} 18:11:19 INFO - Running post-run listener: copy_logs_to_upload_dir 18:11:19 INFO - Copying logs to upload dir... 18:11:19 INFO - mkdir: /builds/slave/test/build/upload/logs 18:11:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.785477 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-08-16 18:11:19.178756) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-16 18:11:19.186764) ========= 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=1258088b6da462a47ba2cd90000001a2-1502921563.454632-356199533 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d0c36c109dc8533dc7f116faaf3e9ba36ce97d243e39c63fb29bd5460c061320efb68b61413fa09bc29a1809d3fba26d823965e12e9b7ba296e5460a1ab059b0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6afe97b546826c99c8b84f8f945d802bbc54aaa929448e0ab9e59e489452b83088e8dadbb03bf45509bf26b6d72feb2da241aafe45b10b84d959bc529e74860e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2aad995b0c5049b0f81c11914bbb3403873bc850db938519b715508c154fe1ce580e0129be5ef8212d2e39634794af04bd3cd7adc59cbd9108a9e65d8d2531bb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c5cd309f0cd0958125aeedfb7b59a702073e175a5470ee946ff9ea014a0a5aa3fb35479b7f8e7ad49617f8f2cf6ccc97cd7a45b82451ca7cb6aad892ba2f222a"} build_url:https://queue.taskcluster.net/v1/task/VGVatiFiSBqe2fkjUp-Rdg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011356 build_url: 'https://queue.taskcluster.net/v1/task/VGVatiFiSBqe2fkjUp-Rdg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d0c36c109dc8533dc7f116faaf3e9ba36ce97d243e39c63fb29bd5460c061320efb68b61413fa09bc29a1809d3fba26d823965e12e9b7ba296e5460a1ab059b0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6afe97b546826c99c8b84f8f945d802bbc54aaa929448e0ab9e59e489452b83088e8dadbb03bf45509bf26b6d72feb2da241aafe45b10b84d959bc529e74860e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2aad995b0c5049b0f81c11914bbb3403873bc850db938519b715508c154fe1ce580e0129be5ef8212d2e39634794af04bd3cd7adc59cbd9108a9e65d8d2531bb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c5cd309f0cd0958125aeedfb7b59a702073e175a5470ee946ff9ea014a0a5aa3fb35479b7f8e7ad49617f8f2cf6ccc97cd7a45b82451ca7cb6aad892ba2f222a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-16 18:11:19.216953) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 18:11:19.217374) ========= 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=1258088b6da462a47ba2cd90000001a2-1502921563.454632-356199533 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004447 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 18:11:19.298576) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-16 18:11:19.298934) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-16 18:11:19.299302) ========= ========= Total master_lag: 0.19 =========