builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-008 starttime: 1504520098.96 results: success (0) revision: 632e42dca494ec3d90b70325d9c359f80cb3f38a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-04 03:14:58.957532) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-04 03:14:58.957990) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-04 03:14:58.958270) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-04 03:14:58.976682) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-04 03:14:58.977091) ========= 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=32c5991c409366f7fec8a718000001d2-1504520097.981278-666853037 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-04 03:14:59-- 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% 51.7M=0s 2017-09-04 03:14:59 (51.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.125136 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-04 03:14:59.119147) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-04 03:14:59.122567) ========= 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=32c5991c409366f7fec8a718000001d2-1504520097.981278-666853037 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014106 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-04 03:14:59.172440) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-04 03:14:59.172794) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 632e42dca494ec3d90b70325d9c359f80cb3f38a --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 632e42dca494ec3d90b70325d9c359f80cb3f38a --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=32c5991c409366f7fec8a718000001d2-1504520097.981278-666853037 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-04 03:14:59,304 truncating revision to first 12 chars 2017-09-04 03:14:59,304 Setting DEBUG logging. 2017-09-04 03:14:59,304 attempt 1/10 2017-09-04 03:14:59,304 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/632e42dca494?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-04 03:15:00,306 unpacking tar archive at: mozilla-central-632e42dca494/testing/mozharness/ program finished with exit code 0 elapsedTime=1.390218 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-04 03:15:00.582206) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-04 03:15:00.585581) ========= script_repo_revision: 632e42dca494ec3d90b70325d9c359f80cb3f38a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-04 03:15:00.585941) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-04 03:15:00.586194) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-04 03:15:00.601475) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-09-04 03:15:00.601848) ========= /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=32c5991c409366f7fec8a718000001d2-1504520097.981278-666853037 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:15:00 INFO - MultiFileLogger online at 20170904 03:15:00 in /builds/slave/test 03:15:00 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 03:15:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:15:00 INFO - {'append_to_log': False, 03:15:00 INFO - 'base_work_dir': '/builds/slave/test', 03:15:00 INFO - 'blob_upload_branch': 'Firefox', 03:15:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:15:00 INFO - 'branch': 'Firefox', 03:15:00 INFO - 'buildbot_json_path': 'buildprops.json', 03:15:00 INFO - 'code_coverage': False, 03:15:00 INFO - 'config_files': ('talos/linux_config.py',), 03:15:00 INFO - 'default_actions': ('clobber', 03:15:00 INFO - 'read-buildbot-config', 03:15:00 INFO - 'download-and-extract', 03:15:00 INFO - 'populate-webroot', 03:15:00 INFO - 'create-virtualenv', 03:15:00 INFO - 'install', 03:15:00 INFO - 'setup-mitmproxy', 03:15:00 INFO - 'run-tests'), 03:15:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:15:00 INFO - 'disable_ccov_upload': False, 03:15:00 INFO - 'disable_stylo': False, 03:15:00 INFO - 'download_minidump_stackwalk': True, 03:15:00 INFO - 'download_symbols': 'ondemand', 03:15:00 INFO - 'enable_stylo': False, 03:15:00 INFO - 'enable_webrender': False, 03:15:00 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 03:15:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:15:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:15:00 INFO - 'gecko_profile': False, 03:15:00 INFO - 'gecko_profile_interval': 0, 03:15:00 INFO - 'installer_path': 'installer.exe', 03:15:00 INFO - 'log_level': 'info', 03:15:00 INFO - 'log_name': 'talos', 03:15:00 INFO - 'log_to_console': True, 03:15:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:15:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:15:00 INFO - 'opt_config_files': (), 03:15:00 INFO - 'pip_index': False, 03:15:00 INFO - 'suite': 'dromaeojs-e10s', 03:15:00 INFO - 'system_bits': '32', 03:15:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:15:00 INFO - 'title': 'talos-linux64-ix-008', 03:15:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:15:00 INFO - 'use_talos_json': True, 03:15:00 INFO - 'verify': 'False', 03:15:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:15:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:15:00 INFO - 'work_dir': 'build'} 03:15:00 INFO - [mozharness: 2017-09-04 10:15:00.873663Z] Running clobber step. 03:15:00 INFO - Running pre-action listener: _resource_record_pre_action 03:15:00 INFO - Running main action method: clobber 03:15:00 INFO - rmtree: /builds/slave/test/build 03:15:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:15:02 INFO - Running post-action listener: _resource_record_post_action 03:15:02 INFO - [mozharness: 2017-09-04 10:15:02.421444Z] Finished clobber step (success) 03:15:02 INFO - [mozharness: 2017-09-04 10:15:02.421540Z] Running read-buildbot-config step. 03:15:02 INFO - Running pre-action listener: _resource_record_pre_action 03:15:02 INFO - Running main action method: read_buildbot_config 03:15:02 INFO - Using buildbot properties: 03:15:02 INFO - { 03:15:02 INFO - "project": "", 03:15:02 INFO - "product": "firefox", 03:15:02 INFO - "who": "archaeopteryx@coole-files.de", 03:15:02 INFO - "installer_path": "public/build/target.tar.bz2", 03:15:02 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 03:15:02 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:15:02 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 03:15:02 INFO - "stage_platform": "linux64-stylosequential", 03:15:02 INFO - "basedir": "/builds/slave/test", 03:15:02 INFO - "buildnumber": 59, 03:15:02 INFO - "platform": "ubuntu64_hw_styloseq", 03:15:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:15:02 INFO - "slavebuilddir": "test", 03:15:02 INFO - "taskId": "NjdKRPYRQw6QgnZqEbJbSA", 03:15:02 INFO - "branch": "mozilla-central", 03:15:02 INFO - "script_repo_revision": "production", 03:15:02 INFO - "revision": "632e42dca494ec3d90b70325d9c359f80cb3f38a", 03:15:02 INFO - "slavename": "talos-linux64-ix-008", 03:15:02 INFO - "repo_path": "mozilla-central" 03:15:02 INFO - } 03:15:02 INFO - Finding installer, test and symbols from parent task. 03:15:02 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NjdKRPYRQw6QgnZqEbJbSA'}, attempt #1 03:15:02 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NjdKRPYRQw6QgnZqEbJbSA'}, attempt #1 03:15:03 INFO - Task dependencies: ZH0GnAa4QqyzRlNalh5SXw 03:15:03 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZH0GnAa4QqyzRlNalh5SXw'}, attempt #1 03:15:03 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/ZH0GnAa4QqyzRlNalh5SXw/artifacts/public/build/target.tar.bz2 03:15:03 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/ZH0GnAa4QqyzRlNalh5SXw/artifacts/public/build/target.test_packages.json 03:15:03 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/ZH0GnAa4QqyzRlNalh5SXw/artifacts/public/build/target.crashreporter-symbols.zip 03:15:03 INFO - Running post-action listener: _resource_record_post_action 03:15:03 INFO - [mozharness: 2017-09-04 10:15:03.857517Z] Finished read-buildbot-config step (success) 03:15:03 INFO - [mozharness: 2017-09-04 10:15:03.857735Z] Running download-and-extract step. 03:15:03 INFO - Running pre-action listener: _resource_record_pre_action 03:15:03 INFO - Running main action method: download_and_extract 03:15:03 INFO - mkdir: /builds/slave/test/build/tests 03:15:03 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')]} 03:15:03 INFO - trying https://queue.taskcluster.net/v1/task/ZH0GnAa4QqyzRlNalh5SXw/artifacts/public/build/target.test_packages.json 03:15:03 INFO - Downloading https://queue.taskcluster.net/v1/task/ZH0GnAa4QqyzRlNalh5SXw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:15:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZH0GnAa4QqyzRlNalh5SXw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:15:04 INFO - Downloaded 989 bytes. 03:15:04 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:15:04 INFO - Using the following test package requirements: 03:15:04 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:15:04 INFO - u'common': [u'target.common.tests.zip'], 03:15:04 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:15:04 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:15:04 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:15:04 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:15:04 INFO - u'mozbase': [u'target.common.tests.zip'], 03:15:04 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:15:04 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:15:04 INFO - u'web-platform': [u'target.common.tests.zip', 03:15:04 INFO - u'target.web-platform.tests.tar.gz'], 03:15:04 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:15:04 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 03:15:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZH0GnAa4QqyzRlNalh5SXw/artifacts/public/build/target.common.tests.zip 03:15:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZH0GnAa4QqyzRlNalh5SXw/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:15:04 INFO - Fetch https://queue.taskcluster.net/v1/task/ZH0GnAa4QqyzRlNalh5SXw/artifacts/public/build/target.common.tests.zip into memory 03:15:05 INFO - Content-Length response header: 55022446 03:15:05 INFO - Bytes received: 55022446 03:15:16 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 03:15:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZH0GnAa4QqyzRlNalh5SXw/artifacts/public/build/target.common.tests.zip 03:15:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZH0GnAa4QqyzRlNalh5SXw/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:15:16 INFO - Fetch https://queue.taskcluster.net/v1/task/ZH0GnAa4QqyzRlNalh5SXw/artifacts/public/build/target.common.tests.zip into memory 03:15:17 INFO - Content-Length response header: 55022446 03:15:17 INFO - Bytes received: 55022446 03:15:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZH0GnAa4QqyzRlNalh5SXw/artifacts/public/build/target.talos.tests.zip 03:15:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZH0GnAa4QqyzRlNalh5SXw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:15:32 INFO - Fetch https://queue.taskcluster.net/v1/task/ZH0GnAa4QqyzRlNalh5SXw/artifacts/public/build/target.talos.tests.zip into memory 03:15:32 INFO - Content-Length response header: 14496650 03:15:32 INFO - Bytes received: 14496650 03:15:33 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')]} 03:15:33 INFO - trying https://queue.taskcluster.net/v1/task/ZH0GnAa4QqyzRlNalh5SXw/artifacts/public/build/target.tar.bz2 03:15:33 INFO - Downloading https://queue.taskcluster.net/v1/task/ZH0GnAa4QqyzRlNalh5SXw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:15:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZH0GnAa4QqyzRlNalh5SXw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:15:34 INFO - Downloaded 62725116 bytes. 03:15:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZH0GnAa4QqyzRlNalh5SXw/artifacts/public/build/target.tar.bz2 03:15:34 INFO - mkdir: /builds/slave/test/properties 03:15:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:15:34 INFO - Writing to file /builds/slave/test/properties/build_url 03:15:34 INFO - Contents: 03:15:34 INFO - build_url:https://queue.taskcluster.net/v1/task/ZH0GnAa4QqyzRlNalh5SXw/artifacts/public/build/target.tar.bz2 03:15:34 INFO - Running post-action listener: _resource_record_post_action 03:15:34 INFO - Running post-action listener: find_tests_for_verification 03:15:34 INFO - Running post-action listener: set_extra_try_arguments 03:15:34 INFO - [mozharness: 2017-09-04 10:15:34.174328Z] Finished download-and-extract step (success) 03:15:34 INFO - [mozharness: 2017-09-04 10:15:34.174425Z] Running populate-webroot step. 03:15:34 INFO - Running pre-action listener: _resource_record_pre_action 03:15:34 INFO - Running main action method: populate_webroot 03:15:34 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:15:34 INFO - 'chromez-stylo-e10s': {'talos_options': ['--enable-stylo'], 03:15:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:15:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:15:34 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--enable-stylo'], 03:15:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:15:34 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:15:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:15:34 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 03:15:34 INFO - 'talos_options': ['--enable-stylo'], 03:15:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:15:34 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:15:34 INFO - 'tests': ['damp', 'tps']}, 03:15:34 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 03:15:34 INFO - 'talos_options': ['--enable-stylo'], 03:15:34 INFO - 'tests': ['damp', 'tps']}, 03:15:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:15:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:15:34 INFO - 'g4-stylo-e10s': {'talos_options': ['--enable-stylo'], 03:15:34 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 03:15:34 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:15:34 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:15:34 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 03:15:34 INFO - 'talos_options': ['--enable-stylo'], 03:15:34 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:15:34 INFO - 'other-e10s': {'tests': ['a11yr', 03:15:34 INFO - 'ts_paint', 03:15:34 INFO - 'tpaint', 03:15:34 INFO - 'sessionrestore', 03:15:34 INFO - 'sessionrestore_many_windows', 03:15:34 INFO - 'sessionrestore_no_auto_restore', 03:15:34 INFO - 'tabpaint']}, 03:15:34 INFO - 'other-stylo-e10s': {'talos_options': ['--enable-stylo'], 03:15:34 INFO - 'tests': ['a11yr', 03:15:34 INFO - 'ts_paint', 03:15:34 INFO - 'tpaint', 03:15:34 INFO - 'sessionrestore', 03:15:34 INFO - 'sessionrestore_many_windows', 03:15:34 INFO - 'sessionrestore_no_auto_restore', 03:15:34 INFO - 'tabpaint']}, 03:15:34 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:15:34 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 03:15:34 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--enable-stylo'], 03:15:34 INFO - 'tests': ['bloom_basic_singleton']}, 03:15:34 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--enable-stylo'], 03:15:34 INFO - 'tests': ['bloom_basic']}, 03:15:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:15:34 INFO - 'tsvgr_opacity', 03:15:34 INFO - 'tart', 03:15:34 INFO - 'tscrollx', 03:15:34 INFO - 'tsvg_static']}, 03:15:34 INFO - 'svgr-stylo-e10s': {'talos_options': ['--enable-stylo'], 03:15:34 INFO - 'tests': ['tsvgx', 03:15:34 INFO - 'tsvgr_opacity', 03:15:34 INFO - 'tart', 03:15:34 INFO - 'tscrollx', 03:15:34 INFO - 'tsvg_static']}, 03:15:34 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:15:34 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 03:15:34 INFO - 'talos_options': ['--enable-stylo'], 03:15:34 INFO - 'tests': ['tp5o']}, 03:15:34 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:15:34 INFO - 'talos_options': ['--mitmproxy', 03:15:34 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:15:34 INFO - '--firstNonBlankPaint'], 03:15:34 INFO - 'tests': ['tp6_google', 03:15:34 INFO - 'tp6_youtube', 03:15:34 INFO - 'tp6_amazon', 03:15:34 INFO - 'tp6_facebook']}, 03:15:34 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:15:34 INFO - 'talos_options': ['--enable-stylo', 03:15:34 INFO - '--mitmproxy', 03:15:34 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:15:34 INFO - '--firstNonBlankPaint'], 03:15:34 INFO - 'tests': ['tp6_google', 03:15:34 INFO - 'tp6_youtube', 03:15:34 INFO - 'tp6_amazon', 03:15:34 INFO - 'tp6_facebook']}, 03:15:34 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:15:34 INFO - 'talos_options': ['--enable-stylo', 03:15:34 INFO - '--stylo-threads=1', 03:15:34 INFO - '--mitmproxy', 03:15:34 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:15:34 INFO - '--firstNonBlankPaint'], 03:15:34 INFO - 'tests': ['tp6_google', 03:15:34 INFO - 'tp6_youtube', 03:15:34 INFO - 'tp6_amazon', 03:15:34 INFO - 'tp6_facebook']}, 03:15:34 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:15:34 INFO - 'talos_options': ['--xperf_path', 03:15:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:15:34 INFO - 'tests': ['tp5n']}, 03:15:34 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 03:15:34 INFO - 'talos_options': ['--enable-stylo', 03:15:34 INFO - '--xperf_path', 03:15:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:15:34 INFO - 'tests': ['tp5n']}}} 03:15:34 INFO - Running post-action listener: _resource_record_post_action 03:15:34 INFO - [mozharness: 2017-09-04 10:15:34.188598Z] Finished populate-webroot step (success) 03:15:34 INFO - [mozharness: 2017-09-04 10:15:34.188687Z] Running create-virtualenv step. 03:15:34 INFO - Running pre-action listener: _resource_record_pre_action 03:15:34 INFO - Running main action method: create_virtualenv 03:15:34 INFO - Creating virtualenv /builds/slave/test/build/venv 03:15:34 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:15:34 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 03:15:34 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:15:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:15:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:15:34 INFO - Installing distribute.............................................................................................................................................................................................done. 03:15:35 INFO - Installing pip...............done. 03:15:35 INFO - Return code: 0 03:15:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:15:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:15:35 INFO - Reading from file tmpfile_stdout 03:15:35 INFO - Output received: 03:15:35 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 03:15:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:15:35 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')]} 03:15:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:15:35 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')]} 03:15:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:15:35 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 0x16631f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19cfa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d3090>, '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 0x19d3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19cdf90>, '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': '32c5991c409366f7fec8a718000001d2-1504520097.981278-666853037', '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 03:15:35 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 03:15:35 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 03:15:35 INFO - Using env: {'DISPLAY': ':0', 03:15:35 INFO - 'HOME': '/home/cltbld', 03:15:35 INFO - 'LANG': 'en_US.UTF-8', 03:15:35 INFO - 'LANGUAGE': 'en_US:en', 03:15:35 INFO - 'LOGNAME': 'cltbld', 03:15:35 INFO - 'MAIL': '/var/mail/cltbld', 03:15:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:35 INFO - 'MOZ_NO_REMOTE': '1', 03:15:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:15:35 INFO - 'NO_EM_RESTART': '1', 03:15:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:15:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:35 INFO - 'PWD': '/builds/slave/test', 03:15:35 INFO - 'SHELL': '/bin/bash', 03:15:35 INFO - 'SHLVL': '1', 03:15:35 INFO - 'TERM': 'linux', 03:15:35 INFO - 'TMOUT': '86400', 03:15:35 INFO - 'USER': 'cltbld', 03:15:35 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1504520097.981278-666853037', 03:15:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:35 INFO - '_': '/tools/buildbot/bin/python'} 03:15:36 INFO - Ignoring indexes: http://pypi.python.org/simple/ 03:15:36 INFO - Downloading/unpacking pip>=1.5 03:15:36 INFO - Running setup.py egg_info for package pip 03:15:36 INFO - warning: no files found matching 'pip/cacert.pem' 03:15:36 INFO - warning: no files found matching '*.html' under directory 'docs' 03:15:36 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:15:36 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:15:36 INFO - Installing collected packages: pip 03:15:36 INFO - Found existing installation: pip 1.1 03:15:36 INFO - Uninstalling pip: 03:15:36 INFO - Successfully uninstalled pip 03:15:36 INFO - Running setup.py install for pip 03:15:36 INFO - warning: no files found matching 'pip/cacert.pem' 03:15:36 INFO - warning: no files found matching '*.html' under directory 'docs' 03:15:36 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:15:36 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:15:36 INFO - Installing pip script to /builds/slave/test/build/venv/bin 03:15:36 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 03:15:36 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 03:15:36 INFO - Successfully installed pip 03:15:36 INFO - Cleaning up... 03:15:36 INFO - Return code: 0 03:15:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:15:36 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')]} 03:15:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:15:36 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')]} 03:15:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:15:36 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 0x16631f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19cfa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d3090>, '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 0x19d3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19cdf90>, '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': '32c5991c409366f7fec8a718000001d2-1504520097.981278-666853037', '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 03:15:36 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 03:15:36 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 03:15:36 INFO - Using env: {'DISPLAY': ':0', 03:15:36 INFO - 'HOME': '/home/cltbld', 03:15:36 INFO - 'LANG': 'en_US.UTF-8', 03:15:36 INFO - 'LANGUAGE': 'en_US:en', 03:15:36 INFO - 'LOGNAME': 'cltbld', 03:15:36 INFO - 'MAIL': '/var/mail/cltbld', 03:15:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:36 INFO - 'MOZ_NO_REMOTE': '1', 03:15:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:15:36 INFO - 'NO_EM_RESTART': '1', 03:15:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:15:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:36 INFO - 'PWD': '/builds/slave/test', 03:15:36 INFO - 'SHELL': '/bin/bash', 03:15:36 INFO - 'SHLVL': '1', 03:15:36 INFO - 'TERM': 'linux', 03:15:36 INFO - 'TMOUT': '86400', 03:15:36 INFO - 'USER': 'cltbld', 03:15:36 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1504520097.981278-666853037', 03:15:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:36 INFO - '_': '/tools/buildbot/bin/python'} 03:15:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:15:36 INFO - Downloading/unpacking psutil>=3.1.1 03:15:36 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 03:15:36 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 03:15:36 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 03:15:36 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 03:15:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:15:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:15:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:15:37 INFO - Installing collected packages: psutil 03:15:37 INFO - Running setup.py install for psutil 03:15:37 INFO - building 'psutil._psutil_linux' extension 03:15:37 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 03:15:38 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 03:15:38 INFO - building 'psutil._psutil_posix' extension 03:15:38 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 03:15:38 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 03:15:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:15:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:15:38 INFO - Successfully installed psutil 03:15:38 INFO - Cleaning up... 03:15:38 INFO - Return code: 0 03:15:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:15:38 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')]} 03:15:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:15:38 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')]} 03:15:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:15:38 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 0x16631f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19cfa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d3090>, '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 0x19d3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19cdf90>, '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': '32c5991c409366f7fec8a718000001d2-1504520097.981278-666853037', '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 03:15:38 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 03:15:38 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 03:15:38 INFO - Using env: {'DISPLAY': ':0', 03:15:38 INFO - 'HOME': '/home/cltbld', 03:15:38 INFO - 'LANG': 'en_US.UTF-8', 03:15:38 INFO - 'LANGUAGE': 'en_US:en', 03:15:38 INFO - 'LOGNAME': 'cltbld', 03:15:38 INFO - 'MAIL': '/var/mail/cltbld', 03:15:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:38 INFO - 'MOZ_NO_REMOTE': '1', 03:15:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:15:38 INFO - 'NO_EM_RESTART': '1', 03:15:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:15:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:38 INFO - 'PWD': '/builds/slave/test', 03:15:38 INFO - 'SHELL': '/bin/bash', 03:15:38 INFO - 'SHLVL': '1', 03:15:38 INFO - 'TERM': 'linux', 03:15:38 INFO - 'TMOUT': '86400', 03:15:38 INFO - 'USER': 'cltbld', 03:15:38 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1504520097.981278-666853037', 03:15:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:38 INFO - '_': '/tools/buildbot/bin/python'} 03:15:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:15:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:15:38 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 03:15:38 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 03:15:38 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 03:15:38 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 03:15:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:15:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:15:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:15:39 INFO - Installing collected packages: mozsystemmonitor 03:15:39 INFO - Running setup.py install for mozsystemmonitor 03:15:39 INFO - Successfully installed mozsystemmonitor 03:15:39 INFO - Cleaning up... 03:15:39 INFO - Return code: 0 03:15:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:15:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:15:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:15:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:15:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:15:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16631f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19cfa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d3090>, '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 0x19d3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19cdf90>, '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': '32c5991c409366f7fec8a718000001d2-1504520097.981278-666853037', '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 03:15:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:15:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:15:39 INFO - Using env: {'DISPLAY': ':0', 03:15:39 INFO - 'HOME': '/home/cltbld', 03:15:39 INFO - 'LANG': 'en_US.UTF-8', 03:15:39 INFO - 'LANGUAGE': 'en_US:en', 03:15:39 INFO - 'LOGNAME': 'cltbld', 03:15:39 INFO - 'MAIL': '/var/mail/cltbld', 03:15:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:39 INFO - 'MOZ_NO_REMOTE': '1', 03:15:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:15:39 INFO - 'NO_EM_RESTART': '1', 03:15:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:15:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:39 INFO - 'PWD': '/builds/slave/test', 03:15:39 INFO - 'SHELL': '/bin/bash', 03:15:39 INFO - 'SHLVL': '1', 03:15:39 INFO - 'TERM': 'linux', 03:15:39 INFO - 'TMOUT': '86400', 03:15:39 INFO - 'USER': 'cltbld', 03:15:39 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1504520097.981278-666853037', 03:15:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:39 INFO - '_': '/tools/buildbot/bin/python'} 03:15:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:15:40 INFO - Downloading/unpacking jsonschema==2.5.1 03:15:40 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 03:15:40 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 03:15:40 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 03:15:40 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 03:15:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:15:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:15:41 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 03:15:41 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 03:15:41 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 03:15:41 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 03:15:41 INFO - Downloading functools32-3.2.3-2.tar.gz 03:15:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:15:41 INFO - warning: no files found matching '*.txt' 03:15:41 INFO - no previously-included directories found matching 'build' 03:15:41 INFO - no previously-included directories found matching 'dist' 03:15:41 INFO - no previously-included directories found matching '.git*' 03:15:41 INFO - Installing collected packages: jsonschema, functools32 03:15:41 INFO - Running setup.py install for functools32 03:15:41 INFO - warning: no files found matching '*.txt' 03:15:41 INFO - no previously-included directories found matching 'build' 03:15:41 INFO - no previously-included directories found matching 'dist' 03:15:41 INFO - no previously-included directories found matching '.git*' 03:15:41 INFO - Successfully installed jsonschema functools32 03:15:41 INFO - Cleaning up... 03:15:41 INFO - Return code: 0 03:15:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:15:41 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')]} 03:15:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:15:41 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')]} 03:15:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:15:41 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 0x16631f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19cfa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d3090>, '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 0x19d3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19cdf90>, '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': '32c5991c409366f7fec8a718000001d2-1504520097.981278-666853037', '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 03:15:41 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 03:15:41 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 03:15:41 INFO - Using env: {'DISPLAY': ':0', 03:15:41 INFO - 'HOME': '/home/cltbld', 03:15:41 INFO - 'LANG': 'en_US.UTF-8', 03:15:41 INFO - 'LANGUAGE': 'en_US:en', 03:15:41 INFO - 'LOGNAME': 'cltbld', 03:15:41 INFO - 'MAIL': '/var/mail/cltbld', 03:15:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:41 INFO - 'MOZ_NO_REMOTE': '1', 03:15:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:15:41 INFO - 'NO_EM_RESTART': '1', 03:15:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:15:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:41 INFO - 'PWD': '/builds/slave/test', 03:15:41 INFO - 'SHELL': '/bin/bash', 03:15:41 INFO - 'SHLVL': '1', 03:15:41 INFO - 'TERM': 'linux', 03:15:41 INFO - 'TMOUT': '86400', 03:15:41 INFO - 'USER': 'cltbld', 03:15:41 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1504520097.981278-666853037', 03:15:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:41 INFO - '_': '/tools/buildbot/bin/python'} 03:15:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:15:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:15:41 INFO - Cleaning up... 03:15:41 INFO - Return code: 0 03:15:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:15:41 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')]} 03:15:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:15:41 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')]} 03:15:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:15:41 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 0x16631f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19cfa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d3090>, '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 0x19d3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19cdf90>, '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': '32c5991c409366f7fec8a718000001d2-1504520097.981278-666853037', '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 03:15:41 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 03:15:41 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 03:15:41 INFO - Using env: {'DISPLAY': ':0', 03:15:41 INFO - 'HOME': '/home/cltbld', 03:15:41 INFO - 'LANG': 'en_US.UTF-8', 03:15:41 INFO - 'LANGUAGE': 'en_US:en', 03:15:41 INFO - 'LOGNAME': 'cltbld', 03:15:41 INFO - 'MAIL': '/var/mail/cltbld', 03:15:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:41 INFO - 'MOZ_NO_REMOTE': '1', 03:15:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:15:41 INFO - 'NO_EM_RESTART': '1', 03:15:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:15:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:41 INFO - 'PWD': '/builds/slave/test', 03:15:41 INFO - 'SHELL': '/bin/bash', 03:15:41 INFO - 'SHLVL': '1', 03:15:41 INFO - 'TERM': 'linux', 03:15:41 INFO - 'TMOUT': '86400', 03:15:41 INFO - 'USER': 'cltbld', 03:15:41 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1504520097.981278-666853037', 03:15:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:41 INFO - '_': '/tools/buildbot/bin/python'} 03:15:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:15:41 INFO - Downloading/unpacking blobuploader==1.2.4 03:15:41 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 03:15:41 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 03:15:41 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 03:15:41 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 03:15:43 INFO - Downloading blobuploader-1.2.4.tar.gz 03:15:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:15:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:15:43 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 03:15:43 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 03:15:43 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 03:15:43 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 03:15:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:15:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:15:43 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 03:15:43 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 03:15:43 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 03:15:43 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 03:15:43 INFO - Downloading docopt-0.6.1.tar.gz 03:15:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:15:43 INFO - Installing collected packages: blobuploader, requests, docopt 03:15:43 INFO - Running setup.py install for blobuploader 03:15:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:15:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:15:43 INFO - Running setup.py install for requests 03:15:44 INFO - Running setup.py install for docopt 03:15:44 INFO - Successfully installed blobuploader requests docopt 03:15:44 INFO - Cleaning up... 03:15:44 INFO - Return code: 0 03:15:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:15:44 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')]} 03:15:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:15:44 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')]} 03:15:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:15:44 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 0x16631f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19cfa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d3090>, '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 0x19d3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19cdf90>, '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': '32c5991c409366f7fec8a718000001d2-1504520097.981278-666853037', '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 03:15:44 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 03:15:44 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 03:15:44 INFO - Using env: {'DISPLAY': ':0', 03:15:44 INFO - 'HOME': '/home/cltbld', 03:15:44 INFO - 'LANG': 'en_US.UTF-8', 03:15:44 INFO - 'LANGUAGE': 'en_US:en', 03:15:44 INFO - 'LOGNAME': 'cltbld', 03:15:44 INFO - 'MAIL': '/var/mail/cltbld', 03:15:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:44 INFO - 'MOZ_NO_REMOTE': '1', 03:15:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:15:44 INFO - 'NO_EM_RESTART': '1', 03:15:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:15:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:44 INFO - 'PWD': '/builds/slave/test', 03:15:44 INFO - 'SHELL': '/bin/bash', 03:15:44 INFO - 'SHLVL': '1', 03:15:44 INFO - 'TERM': 'linux', 03:15:44 INFO - 'TMOUT': '86400', 03:15:44 INFO - 'USER': 'cltbld', 03:15:44 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1504520097.981278-666853037', 03:15:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:44 INFO - '_': '/tools/buildbot/bin/python'} 03:15:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:15:44 INFO - Running setup.py (path:/tmp/pip-JrqQBF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:15:44 INFO - Running setup.py (path:/tmp/pip-tESM9H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:15:44 INFO - Running setup.py (path:/tmp/pip-SBkNxq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:15:44 INFO - Running setup.py (path:/tmp/pip-2xjm5s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:15:44 INFO - Running setup.py (path:/tmp/pip-JZFny4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:15:44 INFO - Running setup.py (path:/tmp/pip-kNp8Pj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:15:44 INFO - Running setup.py (path:/tmp/pip-uwTNyS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:15:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:15:45 INFO - Running setup.py (path:/tmp/pip-gxgEFJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:15:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:15:45 INFO - Running setup.py (path:/tmp/pip-WzelO5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:15:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:15:45 INFO - Running setup.py (path:/tmp/pip-wor6ZS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:15:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:15:45 INFO - Running setup.py (path:/tmp/pip-Oh2ShG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:15:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:15:45 INFO - Running setup.py (path:/tmp/pip-4Du2Tn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:15:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:15:45 INFO - Running setup.py (path:/tmp/pip-FL88wN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:15:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:15:45 INFO - Running setup.py (path:/tmp/pip-PtqYW5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:15:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:15:45 INFO - Running setup.py (path:/tmp/pip-aXn9_m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:15:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:15:45 INFO - Running setup.py (path:/tmp/pip-zZh7DP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:15:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:15:45 INFO - Running setup.py (path:/tmp/pip-66gNb_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:15:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:15:45 INFO - Running setup.py install for manifestparser 03:15:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:15:45 INFO - Running setup.py install for mozcrash 03:15:45 INFO - Running setup.py install for mozdebug 03:15:46 INFO - Running setup.py install for mozdevice 03:15:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:15:46 INFO - Running setup.py install for mozfile 03:15:46 INFO - Running setup.py install for mozhttpd 03:15:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:15:46 INFO - Running setup.py install for mozinfo 03:15:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:15:46 INFO - Running setup.py install for mozInstall 03:15:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:15:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:15:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:15:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:15:46 INFO - Running setup.py install for mozleak 03:15:46 INFO - Running setup.py install for mozlog 03:15:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:15:46 INFO - Running setup.py install for moznetwork 03:15:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:15:46 INFO - Running setup.py install for mozprocess 03:15:46 INFO - Running setup.py install for mozprofile 03:15:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:15:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:15:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:15:47 INFO - Running setup.py install for mozrunner 03:15:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:15:47 INFO - Running setup.py install for mozscreenshot 03:15:47 INFO - Running setup.py install for moztest 03:15:47 INFO - Running setup.py install for mozversion 03:15:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:15:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:15:47 INFO - Cleaning up... 03:15:47 INFO - Return code: 0 03:15:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:15:47 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')]} 03:15:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:15:47 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')]} 03:15:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:15:47 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 0x16631f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19cfa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d3090>, '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 0x19d3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19cdf90>, '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': '32c5991c409366f7fec8a718000001d2-1504520097.981278-666853037', '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 03:15:47 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 03:15:47 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 03:15:47 INFO - Using env: {'DISPLAY': ':0', 03:15:47 INFO - 'HOME': '/home/cltbld', 03:15:47 INFO - 'LANG': 'en_US.UTF-8', 03:15:47 INFO - 'LANGUAGE': 'en_US:en', 03:15:47 INFO - 'LOGNAME': 'cltbld', 03:15:47 INFO - 'MAIL': '/var/mail/cltbld', 03:15:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:47 INFO - 'MOZ_NO_REMOTE': '1', 03:15:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:15:47 INFO - 'NO_EM_RESTART': '1', 03:15:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:15:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:47 INFO - 'PWD': '/builds/slave/test', 03:15:47 INFO - 'SHELL': '/bin/bash', 03:15:47 INFO - 'SHLVL': '1', 03:15:47 INFO - 'TERM': 'linux', 03:15:47 INFO - 'TMOUT': '86400', 03:15:47 INFO - 'USER': 'cltbld', 03:15:47 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1504520097.981278-666853037', 03:15:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:47 INFO - '_': '/tools/buildbot/bin/python'} 03:15:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:15:47 INFO - Running setup.py (path:/tmp/pip-ZJoJ3r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:15:47 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)) 03:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:15:47 INFO - Running setup.py (path:/tmp/pip-MsQZtf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:15:47 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)) 03:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:15:47 INFO - Running setup.py (path:/tmp/pip-WEUK63-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:15:47 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)) 03:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:15:47 INFO - Running setup.py (path:/tmp/pip-nGXyJ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:15:48 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)) 03:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:15:48 INFO - Running setup.py (path:/tmp/pip-xh7qua-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:15:48 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)) 03:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:15:48 INFO - Running setup.py (path:/tmp/pip-80DVS8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:15:48 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)) 03:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:15:48 INFO - Running setup.py (path:/tmp/pip-_agYCJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:15:48 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)) 03:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:15:48 INFO - Running setup.py (path:/tmp/pip-7B8Gwh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:15:48 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)) 03:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:15:48 INFO - Running setup.py (path:/tmp/pip-RTZsIK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:15:48 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)) 03:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:15:48 INFO - Running setup.py (path:/tmp/pip-ZzUVs1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:15:48 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)) 03:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:15:48 INFO - Running setup.py (path:/tmp/pip-j4oyqB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:15:48 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)) 03:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:15:48 INFO - Running setup.py (path:/tmp/pip-IEAtl4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:15:48 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)) 03:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:15:48 INFO - Running setup.py (path:/tmp/pip-N91iAp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:15:48 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)) 03:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:15:48 INFO - Running setup.py (path:/tmp/pip-bn07KB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:15:48 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)) 03:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:15:48 INFO - Running setup.py (path:/tmp/pip-HQGkn4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:15:48 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)) 03:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:15:48 INFO - Running setup.py (path:/tmp/pip-X6vWGJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:15:48 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)) 03:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:15:48 INFO - Running setup.py (path:/tmp/pip-_nfulg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:15:48 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)) 03:15:48 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)) 03:15:48 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)) 03:15:48 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)) 03:15:48 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)) 03:15:48 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)) 03:15:48 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)) 03:15:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:15:48 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 03:15:48 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 03:15:48 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 03:15:48 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 03:15:50 INFO - Downloading blessings-1.6.tar.gz 03:15:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:15:50 INFO - Installing collected packages: blessings 03:15:50 INFO - Running setup.py install for blessings 03:15:50 INFO - Successfully installed blessings 03:15:50 INFO - Cleaning up... 03:15:50 INFO - Return code: 0 03:15:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:15:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:15:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:15:50 INFO - Reading from file tmpfile_stdout 03:15:50 INFO - Current package versions: 03:15:50 INFO - argparse == 1.2.1 03:15:50 INFO - blessings == 1.6 03:15:50 INFO - blobuploader == 1.2.4 03:15:50 INFO - docopt == 0.6.1 03:15:50 INFO - functools32 == 3.2.3-2 03:15:50 INFO - jsonschema == 2.5.1 03:15:50 INFO - manifestparser == 1.1 03:15:50 INFO - mozInstall == 1.13 03:15:50 INFO - mozcrash == 1.0 03:15:50 INFO - mozdebug == 0.1 03:15:50 INFO - mozdevice == 0.51 03:15:50 INFO - mozfile == 1.2 03:15:50 INFO - mozhttpd == 0.7 03:15:50 INFO - mozinfo == 0.10 03:15:50 INFO - mozleak == 0.1 03:15:50 INFO - mozlog == 3.5 03:15:50 INFO - moznetwork == 0.27 03:15:50 INFO - mozprocess == 0.25 03:15:50 INFO - mozprofile == 0.28 03:15:50 INFO - mozrunner == 6.13 03:15:50 INFO - mozscreenshot == 0.1 03:15:50 INFO - mozsystemmonitor == 0.3 03:15:50 INFO - moztest == 0.8 03:15:50 INFO - mozversion == 1.4 03:15:50 INFO - psutil == 3.1.1 03:15:50 INFO - requests == 1.2.3 03:15:50 INFO - wsgiref == 0.1.2 03:15:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:15:50 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')]} 03:15:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:15:50 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')]} 03:15:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:15:50 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 0x16631f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19cfa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d3090>, '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 0x19d3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19cdf90>, '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': '32c5991c409366f7fec8a718000001d2-1504520097.981278-666853037', '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 03:15:50 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 03:15:50 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 03:15:50 INFO - Using env: {'DISPLAY': ':0', 03:15:50 INFO - 'HOME': '/home/cltbld', 03:15:50 INFO - 'LANG': 'en_US.UTF-8', 03:15:50 INFO - 'LANGUAGE': 'en_US:en', 03:15:50 INFO - 'LOGNAME': 'cltbld', 03:15:50 INFO - 'MAIL': '/var/mail/cltbld', 03:15:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:50 INFO - 'MOZ_NO_REMOTE': '1', 03:15:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:15:50 INFO - 'NO_EM_RESTART': '1', 03:15:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:15:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:50 INFO - 'PWD': '/builds/slave/test', 03:15:50 INFO - 'SHELL': '/bin/bash', 03:15:50 INFO - 'SHLVL': '1', 03:15:50 INFO - 'TERM': 'linux', 03:15:50 INFO - 'TMOUT': '86400', 03:15:50 INFO - 'USER': 'cltbld', 03:15:50 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1504520097.981278-666853037', 03:15:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:50 INFO - '_': '/tools/buildbot/bin/python'} 03:15:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:15:50 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)) 03:15:50 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)) 03:15:50 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)) 03:15:50 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)) 03:15:50 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)) 03:15:50 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)) 03:15:50 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)) 03:15:50 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)) 03:15:50 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)) 03:15:50 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:15:50 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 03:15:50 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 03:15:50 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 03:15:50 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 03:15:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:15:52 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)) 03:15:52 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)) 03:15:52 INFO - Installing collected packages: simplejson 03:15:52 INFO - Running setup.py install for simplejson 03:15:53 INFO - building 'simplejson._speedups' extension 03:15:53 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 03:15:53 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 03:15:53 INFO - Successfully installed simplejson 03:15:53 INFO - Cleaning up... 03:15:53 INFO - Return code: 0 03:15:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:15:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:15:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:15:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:15:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:15:53 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 0x16631f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19cfa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d3090>, '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 0x19d3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19cdf90>, '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': '32c5991c409366f7fec8a718000001d2-1504520097.981278-666853037', '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 03:15:53 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 03:15:53 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 03:15:53 INFO - Using env: {'DISPLAY': ':0', 03:15:53 INFO - 'HOME': '/home/cltbld', 03:15:53 INFO - 'LANG': 'en_US.UTF-8', 03:15:53 INFO - 'LANGUAGE': 'en_US:en', 03:15:53 INFO - 'LOGNAME': 'cltbld', 03:15:53 INFO - 'MAIL': '/var/mail/cltbld', 03:15:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:53 INFO - 'MOZ_NO_REMOTE': '1', 03:15:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:15:54 INFO - 'NO_EM_RESTART': '1', 03:15:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:15:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:54 INFO - 'PWD': '/builds/slave/test', 03:15:54 INFO - 'SHELL': '/bin/bash', 03:15:54 INFO - 'SHLVL': '1', 03:15:54 INFO - 'TERM': 'linux', 03:15:54 INFO - 'TMOUT': '86400', 03:15:54 INFO - 'USER': 'cltbld', 03:15:54 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1504520097.981278-666853037', 03:15:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:54 INFO - '_': '/tools/buildbot/bin/python'} 03:15:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:15:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:15:54 INFO - Cleaning up... 03:15:54 INFO - Return code: 0 03:15:54 INFO - Running post-action listener: _resource_record_post_action 03:15:54 INFO - Running post-action listener: _start_resource_monitoring 03:15:54 INFO - Starting resource monitoring. 03:15:54 INFO - [mozharness: 2017-09-04 10:15:54.254146Z] Finished create-virtualenv step (success) 03:15:54 INFO - [mozharness: 2017-09-04 10:15:54.254618Z] Running install step. 03:15:54 INFO - Running pre-action listener: _resource_record_pre_action 03:15:54 INFO - Running main action method: install 03:15:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:15:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:15:54 INFO - Reading from file tmpfile_stdout 03:15:54 INFO - Detecting whether we're running mozinstall >=1.0... 03:15:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:15:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:15:54 INFO - Reading from file tmpfile_stdout 03:15:54 INFO - Output received: 03:15:54 INFO - Usage: mozinstall [options] installer 03:15:54 INFO - Options: 03:15:54 INFO - -h, --help show this help message and exit 03:15:54 INFO - -d DEST, --destination=DEST 03:15:54 INFO - Directory to install application into. [default: 03:15:54 INFO - "/builds/slave/test"] 03:15:54 INFO - --app=APP Application being installed. [default: firefox] 03:15:54 INFO - mkdir: /builds/slave/test/build/application 03:15:54 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'] 03:15:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:16:11 INFO - Reading from file tmpfile_stdout 03:16:11 INFO - Output received: 03:16:11 INFO - /builds/slave/test/build/application/firefox/firefox 03:16:11 INFO - Running post-action listener: _resource_record_post_action 03:16:11 INFO - [mozharness: 2017-09-04 10:16:11.120222Z] Finished install step (success) 03:16:11 INFO - [mozharness: 2017-09-04 10:16:11.120425Z] Running setup-mitmproxy step. 03:16:11 INFO - Running pre-action listener: _resource_record_pre_action 03:16:11 INFO - Running main action method: setup_mitmproxy 03:16:11 INFO - Skipping: mitmproxy is not required 03:16:11 INFO - Running post-action listener: _resource_record_post_action 03:16:11 INFO - [mozharness: 2017-09-04 10:16:11.121561Z] Finished setup-mitmproxy step (success) 03:16:11 INFO - [mozharness: 2017-09-04 10:16:11.121780Z] Running run-tests step. 03:16:11 INFO - Running pre-action listener: _resource_record_pre_action 03:16:11 INFO - Running pre-action listener: _set_gcov_prefix 03:16:11 INFO - Running main action method: run_tests 03:16:11 WARNING - Try message not found. 03:16:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:16:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:16:11 INFO - Python 2.7.3 03:16:11 INFO - Return code: 0 03:16:11 INFO - grabbing minidump binary from tooltool 03:16:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:16:11 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d3090>, '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 0x19d3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19cdf90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:16:11 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:16:11 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:16:11 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:16:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:16:11 INFO - Return code: 0 03:16:11 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:16:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:16:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:16:11 INFO - ENV: RUST_BACKTRACE is now full 03:16:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:16:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:16:11 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/ZH0GnAa4QqyzRlNalh5SXw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 03:16:11 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/ZH0GnAa4QqyzRlNalh5SXw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-008 --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 03:16:11 INFO - Using env: {'DISPLAY': ':0', 03:16:11 INFO - 'HOME': '/home/cltbld', 03:16:11 INFO - 'LANG': 'en_US.UTF-8', 03:16:11 INFO - 'LANGUAGE': 'en_US:en', 03:16:11 INFO - 'LOGNAME': 'cltbld', 03:16:11 INFO - 'MAIL': '/var/mail/cltbld', 03:16:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:16:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:16:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:11 INFO - 'MOZ_NO_REMOTE': '1', 03:16:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:16:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:11 INFO - 'NO_EM_RESTART': '1', 03:16:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:11 INFO - 'PWD': '/builds/slave/test', 03:16:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:16:11 INFO - 'RUST_BACKTRACE': 'full', 03:16:11 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:16:11 INFO - 'SHELL': '/bin/bash', 03:16:11 INFO - 'SHLVL': '1', 03:16:11 INFO - 'STYLO_FORCE_ENABLED': '1', 03:16:11 INFO - 'STYLO_THREADS': '1', 03:16:11 INFO - 'TERM': 'linux', 03:16:11 INFO - 'TMOUT': '86400', 03:16:11 INFO - 'USER': 'cltbld', 03:16:11 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1504520097.981278-666853037', 03:16:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:11 INFO - '_': '/tools/buildbot/bin/python'} 03:16:11 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/ZH0GnAa4QqyzRlNalh5SXw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 03:16:11 INFO - mozversion application_buildid: 20170904091258 03:16:11 INFO - mozversion application_changeset: 632e42dca494ec3d90b70325d9c359f80cb3f38a 03:16:11 INFO - mozversion application_display_name: Nightly 03:16:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:16:11 INFO - mozversion application_name: Firefox 03:16:11 INFO - mozversion application_remotingname: firefox 03:16:11 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:16:11 INFO - mozversion application_vendor: Mozilla 03:16:11 INFO - mozversion application_version: 57.0a1 03:16:11 INFO - mozversion platform_buildid: 20170904091258 03:16:11 INFO - mozversion platform_changeset: 632e42dca494ec3d90b70325d9c359f80cb3f38a 03:16:11 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:16:11 INFO - mozversion platform_version: 57.0a1 03:16:11 INFO - using testdate: 1504520171 03:16:11 INFO - actual date: 1504520171 03:16:11 INFO - starting webserver on 'localhost:42202' 03:16:11 INFO - SUITE-START | Running 2 tests 03:16:11 INFO - TEST-START | dromaeo_css 03:16:11 INFO - Initialising browser for dromaeo_css test... 03:16:11 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:42202/getInfo.html -profile /tmp/tmpDYaMbQ/profile 03:16:11 INFO - TEST-INFO | started process 12475 (/builds/slave/test/build/application/firefox/firefox http://localhost:42202/getInfo.html) 03:16:16 INFO - TEST-INFO | 12475: exit 0 03:16:16 INFO - Browser initialized. 03:16:16 INFO - Running cycle 1/1 for dromaeo_css test... 03:16:16 INFO - Using env: {'DISPLAY': ':0', 03:16:16 INFO - 'HOME': '/home/cltbld', 03:16:16 INFO - 'JSGC_DISABLE_POISONING': '1', 03:16:16 INFO - 'LANG': 'en_US.UTF-8', 03:16:16 INFO - 'LANGUAGE': 'en_US:en', 03:16:16 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:16:16 INFO - 'LOGNAME': 'cltbld', 03:16:16 INFO - 'MAIL': '/var/mail/cltbld', 03:16:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:16:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:16:16 INFO - 'MOZ_CRASHREPORTER': '1', 03:16:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:16 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:16:16 INFO - 'MOZ_NO_REMOTE': '1', 03:16:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:16:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:16 INFO - 'NO_EM_RESTART': '1', 03:16:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:16 INFO - 'PWD': '/builds/slave/test', 03:16:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:16:16 INFO - 'RUST_BACKTRACE': 'full', 03:16:16 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:16:16 INFO - 'SHELL': '/bin/bash', 03:16:16 INFO - 'SHLVL': '1', 03:16:16 INFO - 'STYLO_FORCE_ENABLED': '1', 03:16:16 INFO - 'STYLO_THREADS': '1', 03:16:16 INFO - 'TERM': 'linux', 03:16:16 INFO - 'TMOUT': '86400', 03:16:16 INFO - 'USER': 'cltbld', 03:16:16 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1504520097.981278-666853037', 03:16:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:16 INFO - '_': '/tools/buildbot/bin/python'} 03:16:16 INFO - TEST-INFO | started process 12662 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDYaMbQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:16:17 INFO - PID 12662 | 03:16:17 INFO - PID 12662 | (/builds/slave/test/build/application/firefox/firefox:12714): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:16:17 INFO - PID 12662 | 03:16:28 INFO - PID 12662 | RSS: Main: 172531712 03:16:28 INFO - PID 12662 | 03:19:26 INFO - PID 12662 | Cycle 1(1): loaded http://localhost:42202/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42202/tests/dromaeo/cssquery-ext.html) 03:19:28 INFO - PID 12662 | RSS: Main: 173326336 03:19:28 INFO - PID 12662 | 03:22:30 INFO - PID 12662 | Cycle 1(1): loaded http://localhost:42202/tests/dromaeo/cssquery-ext.html (next: http://localhost:42202/tests/dromaeo/cssquery-jquery.html) 03:22:31 INFO - PID 12662 | RSS: Main: 170549248 03:22:31 INFO - PID 12662 | 03:25:32 INFO - PID 12662 | Cycle 1(1): loaded http://localhost:42202/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42202/tests/dromaeo/cssquery-mootools.html) 03:25:33 INFO - PID 12662 | RSS: Main: 172826624 03:25:33 INFO - PID 12662 | 03:28:35 INFO - PID 12662 | Cycle 1(1): loaded http://localhost:42202/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42202/tests/dromaeo/cssquery-prototype.html) 03:28:35 INFO - PID 12662 | RSS: Main: 171487232 03:28:35 INFO - PID 12662 | 03:31:39 INFO - PID 12662 | Cycle 1(1): loaded http://localhost:42202/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42202/tests/dromaeo/cssquery-yui.html) 03:31:40 INFO - PID 12662 | RSS: Main: 172539904 03:31:40 INFO - PID 12662 | 03:34:41 INFO - PID 12662 | Cycle 1(1): loaded http://localhost:42202/tests/dromaeo/cssquery-yui.html (next: http://localhost:42202/tests/dromaeo/cssquery-dojo.html) 03:34:41 INFO - PID 12662 | RSS: Main: 175370240 03:34:41 INFO - PID 12662 | 03:34:41 INFO - PID 12662 | __start_tp_report 03:34:41 INFO - PID 12662 | _x_x_mozilla_page_load 03:34:41 INFO - PID 12662 | _x_x_mozilla_page_load_details 03:34:41 INFO - PID 12662 | |i|pagename|runs| 03:34:41 INFO - PID 12662 | |0;dojo.html;3354.1614596350914;3388.3223355328932;3398.575178102737;3420.7605467617277;3435.725141988641;6355.777547785829;6394.872102557952;6416.197975253088;6443.259025212102;6443.967780161099;6467.6442795646335;6490.091387205795;6512.674366281691;6514.576552524082;6519.511036672245;5860.73626686798;5980.252468441456;5998.7600495980105;6073.301570319426;6099.420555047263;6024.879502409971;6032.879342413149;6052.9394706053035;6064;6109.14471973924;5783.450572195635;5853.209816674779;5858;5977.8206653800235;6037.909431358533;5931.08068249422;5946.851328716773;5977.880442391128;6007.969960150215;6013.248343957005;5868.354481007086;5902.704864756788;5947.553933454965;5967.850803729942;6008.279006519202;6417.711202995876;6451.741930322782;6466;6467.967660161716;6500.284968653445;6853.074834897275;7000.054992575988;7000.824979375506;7002.929970700278;7017.157941047056;6944.340287672663;6954.9304506955295;7043.788686339418;7056.082709247817;7076.256993015762;6412;6455.5158363122955;6491.058796474532;6511.869762604769;6542.705578248991;6896.793096207121;7102.644867756591;7112.751053713096;7113.217546070032;7218.783436496913;6718.8320291993095;6727.159105111861;6755.763548275787;6756.729730810811;6759.155105611799;6897.310268973163;6904.516683832084;6915.930840691629;6993.615351155633;7002.264762199896;6821.590704557742;6829.453643708492;6908.585484870924;6916.481263905227;6926.030355750199;6815.693293801791;6852.623105729133;6869.107016087976;6952.652367381712;6968.233494315621;5386.757595908115;5394.271773310631;5452.454754524516;5454.427285135083;5465.125579907196;4776.808927642925;4779.95220047802;4821.879453013703;4865.805367785249;4867.63492738039;6033.668148251801;6035.426634469718;6117.449429551361;6122.602030867979;6125.1424800527075;6914.965425172943;6960.895586566206;6963.582185068912;7047.224805271416;7049.506534542636;5946.167536544887;6011.458968692838;6036.788712395133;6041.275046994301;6043.607165534227;5876.08920617305;5947.940520594739;5947.940520594825;5952.5833191676165;5960.314563825129;6716.429103526255;6720.529562930646;6808.8978665320055;6809.421199198025;6815.795526134224;6932.272111428228;6950.200726916368;6978.197507286524;7077.256888026683;7078.469114816512;6534.215894092549;6623.437007854386;6652.434543063894;6691.933080669131;6779.93220067793;6821.3519715626935;6877.037214790033;6886.48351373639;6900.447964162755;6910.274421185703;6974.232834388315;7041.401480874183;7065.222825489295;7068.081149450539;7081.575105493687;6695.732170713117;6698.56459330142;6699.330066993261;6755.054292399166;6798.76204332846;6625.536212465081;6713.798586042427;6721.361470660279;6729.327067293231;6808.455323574201;6626.734930602722;6627.436667883284;6646.60120392778;6650.46796256308;6652.800415987528;6653.733850646114;6696.1629796275465;6776.254611992578;6778.288279730755;6778.593284402951;6504.447121994684;6521.119648847345;6539.11721917535;6550.639714815731;6551.967240163769 03:34:41 INFO - PID 12662 | |1;ext.html;769.3268390158611;829.2868133405267;864.2222000199821;878.0341624213364;887.2768693514781;38003.80998095009;38767.80616096922;38826.22347553051;38837.611623883786;38889.61110388902;35808.641913580854;36015.81992090042;36109.45835812465;36119.458208126896;36124.27751444969;6854.280300568431;6987.475939304547;6989.091418115638;6991;6991.440684745208;6833.180018397775;6892.931070689304;6919.550229235108;6922.930770692279;6926.619035953021;6875.656217189121;7367.778966630983;7639.236076392372;7649.617519124022;7658.3873290136935;7546.169921308651;7588.165301816795;7607.695692172307;7612.771616851475;7620.733274335399;7417.5549467031615;7418.591977441239;7491.175970643225;7626.961865190694;7631.923680763177;36025.81987090048;36241;36266.274674506625;36300.63699362999;36367.27265454676;3452.430348992413;3480.443129099357;3482.5995010573856;3490.9825450872836;3493.1092571394133;30159.396812063856;30175.849120754476;30229.546556801666;30272.24319392011;30415.695843041507;5086.41506226785;5091.414487333967;5117.053345131163;5135.974320128413;5148.665336753136;177100;178612;180099;182799;186480;46504;46837.297440538416;46915.76542117268;46952.76523617428;46968.530314696414;48729.269060964114;48894.51105488899;48969.26546101811;49110;49156.262656060186;15085.622859428602;15288.694226115414;15308.464203753038;15326.080435173702;15426.537203883901;12778.361081945866;12811.615651530468;12848.871511284955;12850.164739291917;12857.4214160363;13716.794248086288;13784.793228101587;13833.446662133401;13843;13858.65353366174;5555.50000499957;5583.3858275589655;5603.131514615241;5623.806715381004;5718.884012915248;1011.6863772230632;1017.29298137795;1026.1585499890168;1028.2134167361974;1029.0841151375282;22094.668579971312;22249.888750556467;22602;22649.773502264765;29094.12717618475;1089.3572792052728;1093.9334149204622;1115.2583531951325;1119.4850368830266;1125.8198688209848;12354.0734444917;12614.936925315315;15775.526734197992;15865.762013569805;16062.277197526138;238771;242343;242816;243819;243961;53817.46182538203;53980.46019539754;54042.45957540453;54235.18647220295;54524;1389.8262717160355;1407.936642851074;1419.4180386041674;1440.5606290081626;1441.077710265431;26777.19668409951;26797;27262.318442038315;27311.044113455933;27322.863385682944;47094;48225.5177448221;48326.75836620935;48396;48420;208003;210054;210557;210718;210737;31054.378912421173;31583;31584.36831263316;34172.60791744554;34189.31621367609;41069.38395924004;41111.7944410276;41132.38301425541;41239.793801032;41414.792926035174;30946;31091.68908310888;31124.377512449173;31145.221369465944;31247.843760781052;30426.543601845548;30596.541051884684;30789.69210307958;30816.691833081382;31114.68885311118;33872.830635846665;33938.830305848314;34043.82978085094;34123;34315.14212144716;32629.18427039343;33000.66999330072;33121;33191.502127467626;33298.83350583328;24213.636795448434;24431;24484;25300;25335.6199657009 03:34:41 INFO - PID 12662 | |2;jquery.html;563.8731285460769;566.7053132371167;571.2459553389527;585.6427579176702;587.5241054745655;21158.365249042534;21858.23496177634;21878;21935.232266870662;22443.438914027156;25215.2435426937;25467.235982920494;25505.61741573878;25638.615420768703;25639;6460.838479038026;6610.93389066108;6628.304028077055;6632.336766323353;6638.966805165967;5961.791337303195;6525.3474652534605;6537.280899101095;6539.836504087389;6564.081028655992;6508.511861610375;6508.60948343101;6510.772122975697;6514.8045558633075;6536.379043990813;6499.35006499351;6515.055316979012;6518.28298887122;6519.185101862267;6519.869602607945;6078.3921607838865;6082.908756368658;6089.0866370044405;6091.878162436771;6092.634441933498;28930.710692893223;28934.42131157386;29598.85200574005;29703.851480742673;29809.105726828013;2015.5968806238811;2072.7305450291515;2073.067119796083;2073.0774805211686;2074.3258441006583;18186.363477278363;19153;19195.904020479808;19205.80794192068;19215.903920480447;2366.9408264793346;2428.429319110008;2430.1130087518104;2459.8032157427365;2504.8747562621797;135610;138662.3066884659;139022.99999999898;139186;139260;14064.226467544384;14384.35270412834;14392.928035359757;14424.855751442561;14514.85485145135;22555.210567630384;22666.320010399715;22675.319740407813;22807.543849122925;22849.31452056441;9717.611295548098;10021.148202402877;10079.445630490394;10080.344777589433;10097.444640544694;7729.884051739228;8117.878231826528;9115.908840911507;9230.676926307548;9313.953430232805;8628.22345988864;9000.549972501349;9017.143371379709;9049.230815380635;9201.907980920105;2537.479816637585;2554.374178326285;2665.2404064841426;2681.8122731408616;2770.252031951362;948.5921053946869;963.1267185324616;966.2366730283138;967.8983706710835;979.4123525884555;19380.903095484715;19391.80608193928;19603;19927.800721992593;20195.990200489916;1034.462079718542;1036.0623635609786;1038.444432228769;1048.7535429174138;1049.7585555322319;10578.735531611772;10758.56965721378;10765.892341076646;10973.890261097447;11138.220324577202;426448;432027;434964;438648;455532;106582;107785;112150;113485.43257283661;113663;1142.5772464188303;1161.866385365677;1163.9301641901513;1185.3776767197292;1186.649938268213;17478.82521174772;17630.73553896667;17649.117544122484;17974.64050718952;18163.545911351794;53837;54659;54882.45117548773;55627;56125.71937140451;66937;67145;67892.660536697;72281.27718722746;75294.62352688202;11667.416629168678;12695.238285702888;13611.251381173734;13629.931850340685;13722.656933576342;20530;20874.060667269707;20889.791102088784;21482.24812131568;21489;16772.24524896407;16910.746338805173;16962.236699348807;16970.40603578869;17042.318307268066;15158.621034474227;15641;15799.447019354728;15895.682086357976;15899.920500397424;17836.55408614795;18287;18288.81711182871;18320.08399580042;18343.816561834745;13728.519501817389;13788.793168102286;13944.30278486092;13965.720685586435;13968.02223844321;17083.316667333664;17139.400120995706;17340.65318693594;17382.478525644252;17390.869593476382 03:34:41 INFO - PID 12662 | |3;mootools.html;1292.9806052909207;1335.6794369351358;1353.627752368098;1357.4502326557747;1362.64571211485;14904.850951490482;15058.849411505882;15598;15632.765508517381;15638.296276667548;15496.845031549681;15782.84217157828;15785;15785.368585256605;15787;2782.526970415029;2830.6603207615117;2831.9292017699618;2832.0512628269553;2833.9858300708465;2704.8377097374123;2760.213339198329;2771.1686494051805;2771.8614069296455;2776.8889244430197;2744.341358074058;2774.736400041993;2781.235160330905;2784.902528411506;2788.8745006474655;2733.180045986206;2812.9296767580768;2814.1979535832293;2816.7183281671873;2816.8732407041734;2738.137486691706;2748.4228312054493;2749.285185851673;2752.1055656911585;2762.82041667293;14871.851281487263;15107.54677359681;15143.167125808077;15144.772828407582;15148.1668508232;8078.23256790604;8374.623141958626;8397.874031889527;8401.117882622299;8401.663933442655;5551.333839939233;5758.596898217126;5932.495737862287;5952.404759524056;5968.582199246054;1853.3513270355402;1900.2304066852946;1907.7138429235588;1922.5866438715743;1954.7165660979222;26343.868280658666;26623.600645990326;26640.333991650168;26949;27637.861810691018;6825.35159159879;6903.344182302673;6970.198427180939;7098.574085554883;7114.537555058904;16199.43301984425;16234.431794887123;16245;16246.593835153979;16272.349106035863;8077.27304542594;8209;8211.34309255258;8212.46618969765;8213.137620549756;7536.397088232929;7559.811004724816;7562.281583249583;7691.615419229016;7692.7692169235015;5056.924146137811;5200.375954885438;5245.291885595472;5257.2639830423;5306.044911915892;1459.919704416246;1478.2756449339747;1504.6238440389902;1506.8342482326934;1521.0341433190003;849.1041950741903;870.4429165334191;880.6213328268906;887.0863011098579;896.0457113174448;7527.962360188164;7540.472166948261;7578.772636820904;7623.656935437808;7625.313721765067;707.0596107177441;707.4729326651677;717.9425645948417;718.0593422616389;724.5652608434897;4833.854984350475;5239;5391.78432862689;5425.294711687456;5440.401555828856;21196.470088247916;21353.25263615766;21956.341309760413;22083;22519.54960900773;22054;22058.669119963215;22113.55772884533;22222.444438888833;22235.110595575996;9950.253730970206;10272.486375681186;10649.775275843222;10683.732906677395;10691.518881650345;8052.436329456882;8808.559572021246;9207.723768286962;9335.113164249386;9403.764905877408;18078.638427231646;19053.42839714811;19206.61586768229;19478.61042779165;19570.412887613395;19768.703469448257;19773.901130494254;19810.40568782939;19829.30597429083;19901.402957911287;12023.158378913742;12308.199967002116;12368.1960672556;12387.19483233587;12390.938045309716;13055.543055992996;13136.540221092217;13218.471261149447;13238.602841914759;13436.059475836597;10348.327358721961;11025.42415045512;11052.834207486734;11328.886711132784;11472.082233421474;10926.890731092906;11026.228164028442;11059.391733454737;11080;11312.20814542974;10170.79658406813;10172.338797978107;10211.489425528545;10269.383836969508;10297.53661085268;7263.164736055422;7306.2693730626515;7324.523905946096;7428;7454.478186527108;7371;7399.334059934632;7411;7411.295926886937;7504.399648028254 03:34:41 INFO - PID 12662 | |4;prototype.html;507.9949200507995;511.205076106654;539.4416778634112;540.6864018869055;545.5362941499728;6370.840728981778;6405.775797847076;6476.22285325761;6513.4789216862655;6551.787919234933;6156.445919867211;6167.938320616792;6235.220597425322;6235.906461403071;6326.8101956941255;5034.01836641855;5041.218611115283;5102.1836506159025;5109.131447653907;5135.871603209912;5056.898862022757;5104.310918026056;5114.7698353574;5163.561097306715;5184.481551844804;4914.901701965977;4966.304717339575;5048.419431765357;5077.162268225738;5094.77073531692;5038.521340472686;5054.166062599704;5056.191009438472;5062.949370506321;5087.643864929457;4533.705309154927;4541.659375546814;4542.977285113587;4569.95430045702;4583.633309335279;6246.281677607042;6267.4672652824565;6283.465905398047;6290.308066112724;6306.49548036156;5818.883622327572;5830.7084645767545;5848.766049358021;5866.9119963200155;5901.586888917777;6554.901676474857;6630.6237882997475;6675.632840193787;6682.83292917676;6755.898661520081;4899.730514821684;4949.554540091373;4951.925721114186;4958.9752051239875;4987.900241995176;7012.368886800213;7028.472864535129;7052.753153639598;7093.858122837566;7133.286671332929;5049.823256186016;5084.898302033938;5093.06463543851;5100.974495127501;5167.741612919339;5136.5377116059735;5140.742962851842;5151.562117220078;5176.058977883294;5199.688018718889;5845.152452894392;5845.590808643439;5860.531157507389;5865.853353666193;5874.236349274567;6732.9127970329355;6753.324667533306;6764.5603035802515;6783.660816959133;6819.113515242987;1690.3745614122608;1749.6850566897826;1768.1159420289855;1808.5478630342413;1890;1462.1373389700127;1469.2580246975422;1477.674911519464;1479.1273148842236;1490.3144553505292;5827.76688932438;5908.729623131047;5939.584229104008;5994.520438364921;6005.519558435315;6641.933580664131;6782.287859774751;6873.965630171817;6889.276625954303;6902;5760.36635970043;5824.592278540462;5853.356130825606;5913.231279933667;5977.880442391128;3584.9962010637064;3604.819759012039;3664.5419322584676;3668.6514781095752;3692.3046176290923;6579.736810527621;6610.471162307004;6652.301508341651;6664.766733164316;6722.6302553359055;7016.824579385556;7052.541584796972;7114.857702846018;7118.430525558047;7134.750283740044;6555.311692272243;6571.408573228241;6597.175353080865;6616.966915165393;6644.136262285871;6770.695318710571;6837.897431538431;6851.760188393382;6885.277045910308;6979.581225126509;6809.127489940306;6885.311468853075;6923.6192009439965;6931.123583712702;6931.30686931323;6588.637624930675;6634.601923884582;6664.5668031579735;6664.8000559983275;6693.19681638187;4972.5027497249985;5021.4225364083595;5032.899342013213;5088.313077734459;5100.311457953128;6891.138607674041;6922.342377474132;6929.5842249465195;6934.722611095702;6961.443084553122;6563.704633291609;6619.404253617197;6663.800085997428;6701.760174367758;6748.662566871735;6471.385218404244;6615.791341199418;6619.536632435684;6683.866322673616;6730.4952128589575;6304.936950630435;6323.620582765049;6409.4231519163495;6432.614043157426;6570.441512471493;6571.34286571339;6663.36698013688;6672.864683301297;6696.397324240842;6723.4285085766305;6333.1766870306565;6350.523710721622;6390.073439351361;6460.967695161682;6491.188601424822 03:34:41 INFO - PID 12662 | |5;yui.html;825.2984962781636;869.4696235296464;875.5534677314572;911.5761171055458;923.2198792020743;17363.913180434098;18109.547261318457;18117.45647630573;18157.636847263046;19412.708809367836;19892.801071989277;20033.699494507593;20063.79936200641;20138.49653758657;20323;920.0385597051081;999.8800143982733;1000.924930630202;1005.5123265216364;1008.1430783833756;959.932804703671;1013.381837079381;1013.6806905824642;1014.8173328800813;1022.9641962531313;1049.5801679328254;1050.4695128959866;1050.8844027157006;1053.1048608682597;1053.2206167436118;1045.4668119259156;1048.3814549415843;1050.1388861133873;1051.0067985753467;1052.7841792432532;775.790536555127;776.0067114093969;776.080344791424;776.7902666280073;776.9689212431496;19330.323438679578;19625.411237662895;19814.900925495425;19826.80173198264;19910.800891991184;20886.686699699363;21180.682289765668;21417.14331426741;21661.35015949524;21671.133154673953;16061.83938160615;16398.180090995404;16526.83473165277;16590.66818663632;16643.41748038825;3755.380362240227;3772.849086036555;3774.641409066134;3778.6032466590887;3778.754380965256;125054;125959.3702031484;126517;126631;128317;16537.586560336087;16683.249253783608;16886.324547017983;17051.744223836653;17144;30145.547816782764;30261.546076808867;30455.543166852516;30498.237544061132;30556.69443305583;7118.145822501333;7401.5189012714;8429.283510901641;8593.914060859312;8607.311415086779;3639.1266096137265;4073.837046518165;4257.297545904953;4270.402143699885;4277.657787377002;5101.413337466239;5211.0359583477175;5234.869128271824;5240.816571419982;5267.683938963674;1062.2882668612049;1069.9465026748787;1083.9458027098613;1085.2999815119363;1087.5160553553592;657.9407853293227;679.9864002720017;683.6308393467572;685.5098604497808;692.8856738638068;11293.943530282297;11437.559294951749;11890.821637675443;12384.256944583354;12695.42870570808;659.9406053455212;669.4744625468984;670.6553360512142;684.7158429251905;686.1765880942788;5506.587005974568;5536.889262214733;5626.099824028136;5642.98426283273;5662.688552129673;106453;106598;108216;109619.35570966442;111205;91735;91780;91819;94649.5267523658;98172.50913745386;80121;81838.18161818424;84392.57803710942;85825;85994;10903.563857445613;12110.878891210976;12159.452824622736;12268;12361.134720569475;39854;40555.79722101489;41564;41812.372814408416;42867.356989644555;52916.73541632421;53839.730801345744;54765.726171368886;55009.449905500434;55771.72114139403;16270.837291626933;16633.83366166323;16694.916525417295;16767.91616041912;16788.160591970107;19316.227350906367;19488.512787179865;19613.31353402624;19686.90156549208;19693.606127877076;17524.737128943332;17697.734533982257;17706.114694265492;17748.733768993734;17816.643667126846;16979.830201697823;17133.485995420157;17204.225809838837;17262.82737172612;17420.651586968444;15936.601584960468;16120.758188626945;16126.2743176555;16203.108829014518;16209.432669856498;13177.27524986135;13571;13622.523211687543;13685.31573421305;13968.161910285415;13284.867151328363;13296.135751176529;13339.66650833737;13358.933205333911;13428.731425371634 03:34:41 INFO - PID 12662 | __end_tp_report 03:34:41 INFO - PID 12662 | __start_cc_report 03:34:41 INFO - PID 12662 | _x_x_mozilla_cycle_collect,350 03:34:41 INFO - PID 12662 | __end_cc_report 03:34:41 INFO - PID 12662 | __startTimestamp1504521281953__endTimestamp 03:34:41 INFO - PID 12662 | 03:34:41 INFO - PID 12662 | ------- Summary: start ------- 03:34:41 INFO - PID 12662 | Number of tests: 6 03:34:41 INFO - PID 12662 | 03:34:41 INFO - PID 12662 | [#0] dojo.html Cycles:165 Average:6383.83 Median:6625.54 stddev:739.42 (11.2%) stddev-sans-first:702.46 03:34:41 INFO - PID 12662 | Values: 3354.2 3388.3 3398.6 3420.8 3435.7 6355.8 6394.9 6416.2 6443.3 6444.0 6467.6 6490.1 6512.7 6514.6 6519.5 5860.7 5980.3 5998.8 6073.3 6099.4 6024.9 6032.9 6052.9 6064.0 6109.1 5783.5 5853.2 5858.0 5977.8 6037.9 5931.1 5946.9 5977.9 6008.0 6013.2 5868.4 5902.7 5947.6 5967.9 6008.3 6417.7 6451.7 6466.0 6468.0 6500.3 6853.1 7000.1 7000.8 7002.9 7017.2 6944.3 6954.9 7043.8 7056.1 7076.3 6412.0 6455.5 6491.1 6511.9 6542.7 6896.8 7102.6 7112.8 7113.2 7218.8 6718.8 6727.2 6755.8 6756.7 6759.2 6897.3 6904.5 6915.9 6993.6 7002.3 6821.6 6829.5 6908.6 6916.5 6926.0 6815.7 6852.6 6869.1 6952.7 6968.2 5386.8 5394.3 5452.5 5454.4 5465.1 4776.8 4780.0 4821.9 4865.8 4867.6 6033.7 6035.4 6117.4 6122.6 6125.1 6915.0 6960.9 6963.6 7047.2 7049.5 5946.2 6011.5 6036.8 6041.3 6043.6 5876.1 5947.9 5947.9 5952.6 5960.3 6716.4 6720.5 6808.9 6809.4 6815.8 6932.3 6950.2 6978.2 7077.3 7078.5 6534.2 6623.4 6652.4 6691.9 6779.9 6821.4 6877.0 6886.5 6900.4 6910.3 6974.2 7041.4 7065.2 7068.1 7081.6 6695.7 6698.6 6699.3 6755.1 6798.8 6625.5 6713.8 6721.4 6729.3 6808.5 6626.7 6627.4 6646.6 6650.5 6652.8 6653.7 6696.2 6776.3 6778.3 6778.6 6504.4 6521.1 6539.1 6550.6 6552.0 03:34:41 INFO - PID 12662 | 03:34:41 INFO - PID 12662 | [#1] ext.html Cycles:180 Average:37842.42 Median:34083.41 stddev:55154.49 (161.8%) stddev-sans-first:55238.96 03:34:41 INFO - PID 12662 | Values: 769.3 829.3 864.2 878.0 887.3 38003.8 38767.8 38826.2 38837.6 38889.6 35808.6 36015.8 36109.5 36119.5 36124.3 6854.3 6987.5 6989.1 6991.0 6991.4 6833.2 6892.9 6919.6 6922.9 6926.6 6875.7 7367.8 7639.2 7649.6 7658.4 7546.2 7588.2 7607.7 7612.8 7620.7 7417.6 7418.6 7491.2 7627.0 7631.9 36025.8 36241.0 36266.3 36300.6 36367.3 3452.4 3480.4 3482.6 3491.0 3493.1 30159.4 30175.8 30229.5 30272.2 30415.7 5086.4 5091.4 5117.1 5136.0 5148.7 177100.0 178612.0 180099.0 182799.0 186480.0 46504.0 46837.3 46915.8 46952.8 46968.5 48729.3 48894.5 48969.3 49110.0 49156.3 15085.6 15288.7 15308.5 15326.1 15426.5 12778.4 12811.6 12848.9 12850.2 12857.4 13716.8 13784.8 13833.4 13843.0 13858.7 5555.5 5583.4 5603.1 5623.8 5718.9 1011.7 1017.3 1026.2 1028.2 1029.1 22094.7 22249.9 22602.0 22649.8 29094.1 1089.4 1093.9 1115.3 1119.5 1125.8 12354.1 12614.9 15775.5 15865.8 16062.3 238771.0 242343.0 242816.0 243819.0 243961.0 53817.5 53980.5 54042.5 54235.2 54524.0 1389.8 1407.9 1419.4 1440.6 1441.1 26777.2 26797.0 27262.3 27311.0 27322.9 47094.0 48225.5 48326.8 48396.0 48420.0 208003.0 210054.0 210557.0 210718.0 210737.0 31054.4 31583.0 31584.4 34172.6 34189.3 41069.4 41111.8 41132.4 41239.8 41414.8 30946.0 31091.7 31124.4 31145.2 31247.8 30426.5 30596.5 30789.7 30816.7 31114.7 33872.8 33938.8 34043.8 34123.0 34315.1 32629.2 33000.7 33121.0 33191.5 33298.8 24213.6 24431.0 24484.0 25300.0 25335.6 03:34:41 INFO - PID 12662 | 03:34:41 INFO - PID 12662 | [#2] jquery.html Cycles:180 Average:32762.90 Median:21868.12 stddev:74476.24 (340.6%) stddev-sans-first:74645.93 03:34:41 INFO - PID 12662 | Values: 563.9 566.7 571.2 585.6 587.5 21158.4 21858.2 21878.0 21935.2 22443.4 25215.2 25467.2 25505.6 25638.6 25639.0 6460.8 6610.9 6628.3 6632.3 6639.0 5961.8 6525.3 6537.3 6539.8 6564.1 6508.5 6508.6 6510.8 6514.8 6536.4 6499.4 6515.1 6518.3 6519.2 6519.9 6078.4 6082.9 6089.1 6091.9 6092.6 28930.7 28934.4 29598.9 29703.9 29809.1 2015.6 2072.7 2073.1 2073.1 2074.3 18186.4 19153.0 19195.9 19205.8 19215.9 2366.9 2428.4 2430.1 2459.8 2504.9 135610.0 138662.3 139023.0 139186.0 139260.0 14064.2 14384.4 14392.9 14424.9 14514.9 22555.2 22666.3 22675.3 22807.5 22849.3 9717.6 10021.1 10079.4 10080.3 10097.4 7729.9 8117.9 9115.9 9230.7 9314.0 8628.2 9000.5 9017.1 9049.2 9201.9 2537.5 2554.4 2665.2 2681.8 2770.3 948.6 963.1 966.2 967.9 979.4 19380.9 19391.8 19603.0 19927.8 20196.0 1034.5 1036.1 1038.4 1048.8 1049.8 10578.7 10758.6 10765.9 10973.9 11138.2 426448.0 432027.0 434964.0 438648.0 455532.0 106582.0 107785.0 112150.0 113485.4 113663.0 1142.6 1161.9 1163.9 1185.4 1186.6 17478.8 17630.7 17649.1 17974.6 18163.5 53837.0 54659.0 54882.5 55627.0 56125.7 66937.0 67145.0 67892.7 72281.3 75294.6 11667.4 12695.2 13611.3 13629.9 13722.7 20530.0 20874.1 20889.8 21482.2 21489.0 16772.2 16910.7 16962.2 16970.4 17042.3 15158.6 15641.0 15799.4 15895.7 15899.9 17836.6 18287.0 18288.8 18320.1 18343.8 13728.5 13788.8 13944.3 13965.7 13968.0 17083.3 17139.4 17340.7 17382.5 17390.9 03:34:41 INFO - PID 12662 | 03:34:41 INFO - PID 12662 | [#3] mootools.html Cycles:180 Average:9427.55 Median:2741.24 stddev:6749.03 (246.2%) stddev-sans-first:6740.29 03:34:41 INFO - PID 12662 | Values: 1293.0 1335.7 1353.6 1357.5 1362.6 14904.9 15058.8 15598.0 15632.8 15638.3 15496.8 15782.8 15785.0 15785.4 15787.0 2782.5 2830.7 2831.9 2832.1 2834.0 2704.8 2760.2 2771.2 2771.9 2776.9 2744.3 2774.7 2781.2 2784.9 2788.9 2733.2 2812.9 2814.2 2816.7 2816.9 2738.1 2748.4 2749.3 2752.1 2762.8 14871.9 15107.5 15143.2 15144.8 15148.2 8078.2 8374.6 8397.9 8401.1 8401.7 5551.3 5758.6 5932.5 5952.4 5968.6 1853.4 1900.2 1907.7 1922.6 1954.7 26343.9 26623.6 26640.3 26949.0 27637.9 6825.4 6903.3 6970.2 7098.6 7114.5 16199.4 16234.4 16245.0 16246.6 16272.3 8077.3 8209.0 8211.3 8212.5 8213.1 7536.4 7559.8 7562.3 7691.6 7692.8 5056.9 5200.4 5245.3 5257.3 5306.0 1459.9 1478.3 1504.6 1506.8 1521.0 849.1 870.4 880.6 887.1 896.0 7528.0 7540.5 7578.8 7623.7 7625.3 707.1 707.5 717.9 718.1 724.6 4833.9 5239.0 5391.8 5425.3 5440.4 21196.5 21353.3 21956.3 22083.0 22519.5 22054.0 22058.7 22113.6 22222.4 22235.1 9950.3 10272.5 10649.8 10683.7 10691.5 8052.4 8808.6 9207.7 9335.1 9403.8 18078.6 19053.4 19206.6 19478.6 19570.4 19768.7 19773.9 19810.4 19829.3 19901.4 12023.2 12308.2 12368.2 12387.2 12390.9 13055.5 13136.5 13218.5 13238.6 13436.1 10348.3 11025.4 11052.8 11328.9 11472.1 10926.9 11026.2 11059.4 11080.0 11312.2 10170.8 10172.3 10211.5 10269.4 10297.5 7263.2 7306.3 7324.5 7428.0 7454.5 7371.0 7399.3 7411.0 7411.3 7504.4 03:34:41 INFO - PID 12662 | 03:34:41 INFO - PID 12662 | [#4] prototype.html Cycles:180 Average:5631.93 Median:6275.47 stddev:1564.91 (24.9%) stddev-sans-first:1521.30 03:34:41 INFO - PID 12662 | Values: 508.0 511.2 539.4 540.7 545.5 6370.8 6405.8 6476.2 6513.5 6551.8 6156.4 6167.9 6235.2 6235.9 6326.8 5034.0 5041.2 5102.2 5109.1 5135.9 5056.9 5104.3 5114.8 5163.6 5184.5 4914.9 4966.3 5048.4 5077.2 5094.8 5038.5 5054.2 5056.2 5062.9 5087.6 4533.7 4541.7 4543.0 4570.0 4583.6 6246.3 6267.5 6283.5 6290.3 6306.5 5818.9 5830.7 5848.8 5866.9 5901.6 6554.9 6630.6 6675.6 6682.8 6755.9 4899.7 4949.6 4951.9 4959.0 4987.9 7012.4 7028.5 7052.8 7093.9 7133.3 5049.8 5084.9 5093.1 5101.0 5167.7 5136.5 5140.7 5151.6 5176.1 5199.7 5845.2 5845.6 5860.5 5865.9 5874.2 6732.9 6753.3 6764.6 6783.7 6819.1 1690.4 1749.7 1768.1 1808.5 1890.0 1462.1 1469.3 1477.7 1479.1 1490.3 5827.8 5908.7 5939.6 5994.5 6005.5 6641.9 6782.3 6874.0 6889.3 6902.0 5760.4 5824.6 5853.4 5913.2 5977.9 3585.0 3604.8 3664.5 3668.7 3692.3 6579.7 6610.5 6652.3 6664.8 6722.6 7016.8 7052.5 7114.9 7118.4 7134.8 6555.3 6571.4 6597.2 6617.0 6644.1 6770.7 6837.9 6851.8 6885.3 6979.6 6809.1 6885.3 6923.6 6931.1 6931.3 6588.6 6634.6 6664.6 6664.8 6693.2 4972.5 5021.4 5032.9 5088.3 5100.3 6891.1 6922.3 6929.6 6934.7 6961.4 6563.7 6619.4 6663.8 6701.8 6748.7 6471.4 6615.8 6619.5 6683.9 6730.5 6304.9 6323.6 6409.4 6432.6 6570.4 6571.3 6663.4 6672.9 6696.4 6723.4 6333.2 6350.5 6390.1 6461.0 6491.2 03:34:41 INFO - PID 12662 | 03:34:41 INFO - PID 12662 | [#5] yui.html Cycles:180 Average:22888.82 Median:19619.36 stddev:31154.71 (158.8%) stddev-sans-first:31198.05 03:34:41 INFO - PID 12662 | Values: 825.3 869.5 875.6 911.6 923.2 17363.9 18109.5 18117.5 18157.6 19412.7 19892.8 20033.7 20063.8 20138.5 20323.0 920.0 999.9 1000.9 1005.5 1008.1 959.9 1013.4 1013.7 1014.8 1023.0 1049.6 1050.5 1050.9 1053.1 1053.2 1045.5 1048.4 1050.1 1051.0 1052.8 775.8 776.0 776.1 776.8 777.0 19330.3 19625.4 19814.9 19826.8 19910.8 20886.7 21180.7 21417.1 21661.4 21671.1 16061.8 16398.2 16526.8 16590.7 16643.4 3755.4 3772.8 3774.6 3778.6 3778.8 125054.0 125959.4 126517.0 126631.0 128317.0 16537.6 16683.2 16886.3 17051.7 17144.0 30145.5 30261.5 30455.5 30498.2 30556.7 7118.1 7401.5 8429.3 8593.9 8607.3 3639.1 4073.8 4257.3 4270.4 4277.7 5101.4 5211.0 5234.9 5240.8 5267.7 1062.3 1069.9 1083.9 1085.3 1087.5 657.9 680.0 683.6 685.5 692.9 11293.9 11437.6 11890.8 12384.3 12695.4 659.9 669.5 670.7 684.7 686.2 5506.6 5536.9 5626.1 5643.0 5662.7 106453.0 106598.0 108216.0 109619.4 111205.0 91735.0 91780.0 91819.0 94649.5 98172.5 80121.0 81838.2 84392.6 85825.0 85994.0 10903.6 12110.9 12159.5 12268.0 12361.1 39854.0 40555.8 41564.0 41812.4 42867.4 52916.7 53839.7 54765.7 55009.4 55771.7 16270.8 16633.8 16694.9 16767.9 16788.2 19316.2 19488.5 19613.3 19686.9 19693.6 17524.7 17697.7 17706.1 17748.7 17816.6 16979.8 17133.5 17204.2 17262.8 17420.7 15936.6 16120.8 16126.3 16203.1 16209.4 13177.3 13571.0 13622.5 13685.3 13968.2 13284.9 13296.1 13339.7 13358.9 13428.7 03:34:41 INFO - PID 12662 | -------- Summary: end -------- 03:34:41 INFO - PID 12662 | 03:34:42 INFO - TEST-INFO | 12662: exit 0 03:34:42 INFO - TEST-OK | dromaeo_css | took 1111214ms 03:34:42 INFO - TEST-START | kraken 03:34:42 INFO - Initialising browser for kraken test... 03:34:42 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:42202/getInfo.html -profile /tmp/tmp_3T69A/profile 03:34:42 INFO - TEST-INFO | started process 13036 (/builds/slave/test/build/application/firefox/firefox http://localhost:42202/getInfo.html) 03:34:48 INFO - TEST-INFO | 13036: exit 0 03:34:48 INFO - Browser initialized. 03:34:48 INFO - Running cycle 1/1 for kraken test... 03:34:48 INFO - Using env: {'DISPLAY': ':0', 03:34:48 INFO - 'HOME': '/home/cltbld', 03:34:48 INFO - 'JSGC_DISABLE_POISONING': '1', 03:34:48 INFO - 'LANG': 'en_US.UTF-8', 03:34:48 INFO - 'LANGUAGE': 'en_US:en', 03:34:48 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:34:48 INFO - 'LOGNAME': 'cltbld', 03:34:48 INFO - 'MAIL': '/var/mail/cltbld', 03:34:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:34:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:34:48 INFO - 'MOZ_CRASHREPORTER': '1', 03:34:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:48 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:34:48 INFO - 'MOZ_NO_REMOTE': '1', 03:34:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:34:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:48 INFO - 'NO_EM_RESTART': '1', 03:34:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:48 INFO - 'PWD': '/builds/slave/test', 03:34:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:34:48 INFO - 'RUST_BACKTRACE': 'full', 03:34:48 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:34:48 INFO - 'SHELL': '/bin/bash', 03:34:48 INFO - 'SHLVL': '1', 03:34:48 INFO - 'STYLO_FORCE_ENABLED': '1', 03:34:48 INFO - 'STYLO_THREADS': '1', 03:34:48 INFO - 'TERM': 'linux', 03:34:48 INFO - 'TMOUT': '86400', 03:34:48 INFO - 'USER': 'cltbld', 03:34:48 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1504520097.981278-666853037', 03:34:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:48 INFO - '_': '/tools/buildbot/bin/python'} 03:34:48 INFO - TEST-INFO | started process 13219 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_3T69A/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:34:49 INFO - PID 13219 | 03:34:49 INFO - PID 13219 | (/builds/slave/test/build/application/firefox/firefox:13271): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:34:49 INFO - PID 13219 | 03:34:59 INFO - PID 13219 | RSS: Main: 172802048 03:34:59 INFO - PID 13219 | 03:35:02 INFO - PID 13219 | Cycle 1(1): loaded http://localhost:42202/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42202/tests/kraken/driver.html?testName=audio-beat-detection) 03:35:02 INFO - PID 13219 | RSS: Main: 178589696 03:35:02 INFO - PID 13219 | 03:35:05 INFO - PID 13219 | Cycle 1(1): loaded http://localhost:42202/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42202/tests/kraken/driver.html?testName=audio-dft) 03:35:06 INFO - PID 13219 | RSS: Main: 182931456 03:35:06 INFO - PID 13219 | 03:35:09 INFO - PID 13219 | Cycle 1(1): loaded http://localhost:42202/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42202/tests/kraken/driver.html?testName=audio-fft) 03:35:09 INFO - PID 13219 | RSS: Main: 174776320 03:35:09 INFO - PID 13219 | 03:35:12 INFO - PID 13219 | Cycle 1(1): loaded http://localhost:42202/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42202/tests/kraken/driver.html?testName=audio-oscillator) 03:35:12 INFO - PID 13219 | RSS: Main: 175300608 03:35:12 INFO - PID 13219 | 03:35:14 INFO - PID 13219 | Cycle 1(1): loaded http://localhost:42202/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42202/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:35:15 INFO - PID 13219 | RSS: Main: 175439872 03:35:15 INFO - PID 13219 | 03:35:18 INFO - PID 13219 | Cycle 1(1): loaded http://localhost:42202/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42202/tests/kraken/driver.html?testName=imaging-darkroom) 03:35:19 INFO - PID 13219 | RSS: Main: 176406528 03:35:19 INFO - PID 13219 | 03:35:22 INFO - PID 13219 | Cycle 1(1): loaded http://localhost:42202/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42202/tests/kraken/driver.html?testName=imaging-desaturate) 03:35:23 INFO - PID 13219 | RSS: Main: 177266688 03:35:23 INFO - PID 13219 | 03:35:26 INFO - PID 13219 | Cycle 1(1): loaded http://localhost:42202/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42202/tests/kraken/driver.html?testName=json-parse-financial) 03:35:26 INFO - PID 13219 | RSS: Main: 177254400 03:35:26 INFO - PID 13219 | 03:35:28 INFO - PID 13219 | Cycle 1(1): loaded http://localhost:42202/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42202/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:35:29 INFO - PID 13219 | RSS: Main: 177221632 03:35:29 INFO - PID 13219 | 03:35:30 INFO - PID 13219 | Cycle 1(1): loaded http://localhost:42202/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42202/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:35:31 INFO - PID 13219 | RSS: Main: 177278976 03:35:31 INFO - PID 13219 | 03:35:33 INFO - PID 13219 | Cycle 1(1): loaded http://localhost:42202/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42202/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:35:34 INFO - PID 13219 | RSS: Main: 174731264 03:35:34 INFO - PID 13219 | 03:35:36 INFO - PID 13219 | Cycle 1(1): loaded http://localhost:42202/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42202/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:35:37 INFO - PID 13219 | RSS: Main: 174288896 03:35:37 INFO - PID 13219 | 03:35:40 INFO - PID 13219 | Cycle 1(1): loaded http://localhost:42202/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42202/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:35:41 INFO - PID 13219 | RSS: Main: 174428160 03:35:41 INFO - PID 13219 | 03:35:42 INFO - PID 13219 | Cycle 1(1): loaded http://localhost:42202/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42202/tests/kraken/driver.html?testName=ai-astar) 03:35:43 INFO - PID 13219 | RSS: Main: 176300032 03:35:43 INFO - PID 13219 | 03:35:43 INFO - PID 13219 | __start_tp_report 03:35:43 INFO - PID 13219 | _x_x_mozilla_page_load 03:35:43 INFO - PID 13219 | _x_x_mozilla_page_load_details 03:35:43 INFO - PID 13219 | |i|pagename|runs| 03:35:43 INFO - PID 13219 | |0;ai-astar;103;108;95;106;107;108;110;107;108;108 03:35:43 INFO - PID 13219 | |1;audio-beat-detection;142;116;148;180;117;147;144;118;168;118 03:35:43 INFO - PID 13219 | |2;audio-dft;162;163;163;164;164;163;166;170;164;166 03:35:43 INFO - PID 13219 | |3;audio-fft;74;73;73;184;76;76;76;73;157;76 03:35:43 INFO - PID 13219 | |4;audio-oscillator;80;78;134;79;79;79;125;78;79;129 03:35:43 INFO - PID 13219 | |5;imaging-gaussian-blur;114;114;115;115;114;113;114;113;115;113 03:35:43 INFO - PID 13219 | |6;imaging-darkroom;148;148;147;148;148;147;148;147;148;147 03:35:43 INFO - PID 13219 | |7;imaging-desaturate;94;94;93;93;101;93;94;93;95;94 03:35:43 INFO - PID 13219 | |8;json-parse-financial;52;53;53;52;54;52;53;52;53;52 03:35:43 INFO - PID 13219 | |9;json-stringify-tinderbox;38;38;38;38;38;38;39;38;39;38 03:35:43 INFO - PID 13219 | |10;stanford-crypto-aes;75;77;75;78;75;75;77;75;74;75 03:35:43 INFO - PID 13219 | |11;stanford-crypto-ccm;128;129;120;121;130;119;116;116;118;159 03:35:43 INFO - PID 13219 | |12;stanford-crypto-pbkdf2;170;172;171;169;172;177;170;169;168;169 03:35:43 INFO - PID 13219 | |13;stanford-crypto-sha256-iterative;66;64;66;64;68;63;64;65;64;66 03:35:43 INFO - PID 13219 | __end_tp_report 03:35:43 INFO - PID 13219 | __start_cc_report 03:35:43 INFO - PID 13219 | _x_x_mozilla_cycle_collect,955 03:35:43 INFO - PID 13219 | __end_cc_report 03:35:43 INFO - PID 13219 | __startTimestamp1504521343113__endTimestamp 03:35:43 INFO - PID 13219 | 03:35:43 INFO - PID 13219 | ------- Summary: start ------- 03:35:43 INFO - PID 13219 | Number of tests: 14 03:35:43 INFO - PID 13219 | 03:35:43 INFO - PID 13219 | [#0] ai-astar Cycles:10 Average:106.00 Median:108.00 stddev:4.27 (4.0%) stddev-sans-first:4.39 03:35:43 INFO - PID 13219 | Values: 103.0 108.0 95.0 106.0 107.0 108.0 110.0 107.0 108.0 108.0 03:35:43 INFO - PID 13219 | 03:35:43 INFO - PID 13219 | [#1] audio-beat-detection Cycles:10 Average:139.80 Median:145.50 stddev:22.58 (15.5%) stddev-sans-first:23.94 03:35:43 INFO - PID 13219 | Values: 142.0 116.0 148.0 180.0 117.0 147.0 144.0 118.0 168.0 118.0 03:35:43 INFO - PID 13219 | 03:35:43 INFO - PID 13219 | [#2] audio-dft Cycles:10 Average:164.50 Median:164.00 stddev:2.32 (1.4%) stddev-sans-first:2.28 03:35:43 INFO - PID 13219 | Values: 162.0 163.0 163.0 164.0 164.0 163.0 166.0 170.0 164.0 166.0 03:35:43 INFO - PID 13219 | 03:35:43 INFO - PID 13219 | [#3] audio-fft Cycles:10 Average:93.80 Median:75.00 stddev:40.94 (54.6%) stddev-sans-first:42.80 03:35:43 INFO - PID 13219 | Values: 74.0 73.0 73.0 184.0 76.0 76.0 76.0 73.0 157.0 76.0 03:35:43 INFO - PID 13219 | 03:35:43 INFO - PID 13219 | [#4] audio-oscillator Cycles:10 Average:94.00 Median:79.00 stddev:24.48 (31.0%) stddev-sans-first:25.44 03:35:43 INFO - PID 13219 | Values: 80.0 78.0 134.0 79.0 79.0 79.0 125.0 78.0 79.0 129.0 03:35:43 INFO - PID 13219 | 03:35:43 INFO - PID 13219 | [#5] imaging-gaussian-blur Cycles:10 Average:114.00 Median:114.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 03:35:43 INFO - PID 13219 | Values: 114.0 114.0 115.0 115.0 114.0 113.0 114.0 113.0 115.0 113.0 03:35:43 INFO - PID 13219 | 03:35:43 INFO - PID 13219 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:148.00 stddev:0.52 (0.3%) stddev-sans-first:0.53 03:35:43 INFO - PID 13219 | Values: 148.0 148.0 147.0 148.0 148.0 147.0 148.0 147.0 148.0 147.0 03:35:43 INFO - PID 13219 | 03:35:43 INFO - PID 13219 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.00 stddev:2.41 (2.6%) stddev-sans-first:2.55 03:35:43 INFO - PID 13219 | Values: 94.0 94.0 93.0 93.0 101.0 93.0 94.0 93.0 95.0 94.0 03:35:43 INFO - PID 13219 | 03:35:43 INFO - PID 13219 | [#8] json-parse-financial Cycles:10 Average:52.60 Median:53.00 stddev:0.70 (1.3%) stddev-sans-first:0.71 03:35:43 INFO - PID 13219 | Values: 52.0 53.0 53.0 52.0 54.0 52.0 53.0 52.0 53.0 52.0 03:35:43 INFO - PID 13219 | 03:35:43 INFO - PID 13219 | [#9] json-stringify-tinderbox Cycles:10 Average:38.20 Median:38.00 stddev:0.42 (1.1%) stddev-sans-first:0.44 03:35:43 INFO - PID 13219 | Values: 38.0 38.0 38.0 38.0 38.0 38.0 39.0 38.0 39.0 38.0 03:35:43 INFO - PID 13219 | 03:35:43 INFO - PID 13219 | [#10] stanford-crypto-aes Cycles:10 Average:75.60 Median:75.00 stddev:1.26 (1.7%) stddev-sans-first:1.32 03:35:43 INFO - PID 13219 | Values: 75.0 77.0 75.0 78.0 75.0 75.0 77.0 75.0 74.0 75.0 03:35:43 INFO - PID 13219 | 03:35:43 INFO - PID 13219 | [#11] stanford-crypto-ccm Cycles:10 Average:125.60 Median:124.50 stddev:12.87 (10.3%) stddev-sans-first:13.62 03:35:43 INFO - PID 13219 | Values: 128.0 129.0 120.0 121.0 130.0 119.0 116.0 116.0 118.0 159.0 03:35:43 INFO - PID 13219 | 03:35:43 INFO - PID 13219 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.70 Median:170.50 stddev:2.58 (1.5%) stddev-sans-first:2.73 03:35:43 INFO - PID 13219 | Values: 170.0 172.0 171.0 169.0 172.0 177.0 170.0 169.0 168.0 169.0 03:35:43 INFO - PID 13219 | 03:35:43 INFO - PID 13219 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.00 Median:65.50 stddev:1.49 (2.3%) stddev-sans-first:1.54 03:35:43 INFO - PID 13219 | Values: 66.0 64.0 66.0 64.0 68.0 63.0 64.0 65.0 64.0 66.0 03:35:43 INFO - PID 13219 | -------- Summary: end -------- 03:35:43 INFO - PID 13219 | 03:35:43 INFO - PID 13219 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:35:43 INFO - TEST-INFO | 13219: exit 0 03:35:43 INFO - TEST-OK | kraken | took 61156ms 03:35:43 INFO - SUITE-END | took 1172s 03:35:44 INFO - Completed test suite (00:19:32) 03:35:44 INFO - javascript benchmark 03:35:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8546.337103973612, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3354.1614596350914, 3388.3223355328932, 3398.575178102737, 3420.7605467617277, 3435.725141988641, 6355.777547785829, 6394.872102557952, 6416.197975253088, 6443.259025212102, 6443.967780161099, 6467.6442795646335, 6490.091387205795, 6512.674366281691, 6514.576552524082, 6519.511036672245, 5860.73626686798, 5980.252468441456, 5998.7600495980105, 6073.301570319426, 6099.420555047263, 6024.879502409971, 6032.879342413149, 6052.9394706053035, 6064.0, 6109.14471973924, 5783.450572195635, 5853.209816674779, 5858.0, 5977.8206653800235, 6037.909431358533, 5931.08068249422, 5946.851328716773, 5977.880442391128, 6007.969960150215, 6013.248343957005, 5868.354481007086, 5902.704864756788, 5947.553933454965, 5967.850803729942, 6008.279006519202, 6417.711202995876, 6451.741930322782, 6466.0, 6467.967660161716, 6500.284968653445, 6853.074834897275, 7000.054992575988, 7000.824979375506, 7002.929970700278, 7017.157941047056, 6944.340287672663, 6954.9304506955295, 7043.788686339418, 7056.082709247817, 7076.256993015762, 6412.0, 6455.5158363122955, 6491.058796474532, 6511.869762604769, 6542.705578248991, 6896.793096207121, 7102.644867756591, 7112.751053713096, 7113.217546070032, 7218.783436496913, 6718.8320291993095, 6727.159105111861, 6755.763548275787, 6756.729730810811, 6759.155105611799, 6897.310268973163, 6904.516683832084, 6915.930840691629, 6993.615351155633, 7002.264762199896, 6821.590704557742, 6829.453643708492, 6908.585484870924, 6916.481263905227, 6926.030355750199, 6815.693293801791, 6852.623105729133, 6869.107016087976, 6952.652367381712, 6968.233494315621, 5386.757595908115, 5394.271773310631, 5452.454754524516, 5454.427285135083, 5465.125579907196, 4776.808927642925, 4779.95220047802, 4821.879453013703, 4865.805367785249, 4867.63492738039, 6033.668148251801, 6035.426634469718, 6117.449429551361, 6122.602030867979, 6125.1424800527075, 6914.965425172943, 6960.895586566206, 6963.582185068912, 7047.224805271416, 7049.506534542636, 5946.167536544887, 6011.458968692838, 6036.788712395133, 6041.275046994301, 6043.607165534227, 5876.08920617305, 5947.940520594739, 5947.940520594825, 5952.5833191676165, 5960.314563825129, 6716.429103526255, 6720.529562930646, 6808.8978665320055, 6809.421199198025, 6815.795526134224, 6932.272111428228, 6950.200726916368, 6978.197507286524, 7077.256888026683, 7078.469114816512, 6534.215894092549, 6623.437007854386, 6652.434543063894, 6691.933080669131, 6779.93220067793, 6821.3519715626935, 6877.037214790033, 6886.48351373639, 6900.447964162755, 6910.274421185703, 6974.232834388315, 7041.401480874183, 7065.222825489295, 7068.081149450539, 7081.575105493687, 6695.732170713117, 6698.56459330142, 6699.330066993261, 6755.054292399166, 6798.76204332846, 6625.536212465081, 6713.798586042427, 6721.361470660279, 6729.327067293231, 6808.455323574201, 6626.734930602722, 6627.436667883284, 6646.60120392778, 6650.46796256308, 6652.800415987528, 6653.733850646114, 6696.1629796275465, 6776.254611992578, 6778.288279730755, 6778.593284402951, 6504.447121994684, 6521.119648847345, 6539.11721917535, 6550.639714815731, 6551.967240163769], "value": 6330.3898893190835, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [769.3268390158611, 829.2868133405267, 864.2222000199821, 878.0341624213364, 887.2768693514781, 38003.80998095009, 38767.80616096922, 38826.22347553051, 38837.611623883786, 38889.61110388902, 35808.641913580854, 36015.81992090042, 36109.45835812465, 36119.458208126896, 36124.27751444969, 6854.280300568431, 6987.475939304547, 6989.091418115638, 6991.0, 6991.440684745208, 6833.180018397775, 6892.931070689304, 6919.550229235108, 6922.930770692279, 6926.619035953021, 6875.656217189121, 7367.778966630983, 7639.236076392372, 7649.617519124022, 7658.3873290136935, 7546.169921308651, 7588.165301816795, 7607.695692172307, 7612.771616851475, 7620.733274335399, 7417.5549467031615, 7418.591977441239, 7491.175970643225, 7626.961865190694, 7631.923680763177, 36025.81987090048, 36241.0, 36266.274674506625, 36300.63699362999, 36367.27265454676, 3452.430348992413, 3480.443129099357, 3482.5995010573856, 3490.9825450872836, 3493.1092571394133, 30159.396812063856, 30175.849120754476, 30229.546556801666, 30272.24319392011, 30415.695843041507, 5086.41506226785, 5091.414487333967, 5117.053345131163, 5135.974320128413, 5148.665336753136, 177100.0, 178612.0, 180099.0, 182799.0, 186480.0, 46504.0, 46837.297440538416, 46915.76542117268, 46952.76523617428, 46968.530314696414, 48729.269060964114, 48894.51105488899, 48969.26546101811, 49110.0, 49156.262656060186, 15085.622859428602, 15288.694226115414, 15308.464203753038, 15326.080435173702, 15426.537203883901, 12778.361081945866, 12811.615651530468, 12848.871511284955, 12850.164739291917, 12857.4214160363, 13716.794248086288, 13784.793228101587, 13833.446662133401, 13843.0, 13858.65353366174, 5555.50000499957, 5583.3858275589655, 5603.131514615241, 5623.806715381004, 5718.884012915248, 1011.6863772230632, 1017.29298137795, 1026.1585499890168, 1028.2134167361974, 1029.0841151375282, 22094.668579971312, 22249.888750556467, 22602.0, 22649.773502264765, 29094.12717618475, 1089.3572792052728, 1093.9334149204622, 1115.2583531951325, 1119.4850368830266, 1125.8198688209848, 12354.0734444917, 12614.936925315315, 15775.526734197992, 15865.762013569805, 16062.277197526138, 238771.0, 242343.0, 242816.0, 243819.0, 243961.0, 53817.46182538203, 53980.46019539754, 54042.45957540453, 54235.18647220295, 54524.0, 1389.8262717160355, 1407.936642851074, 1419.4180386041674, 1440.5606290081626, 1441.077710265431, 26777.19668409951, 26797.0, 27262.318442038315, 27311.044113455933, 27322.863385682944, 47094.0, 48225.5177448221, 48326.75836620935, 48396.0, 48420.0, 208003.0, 210054.0, 210557.0, 210718.0, 210737.0, 31054.378912421173, 31583.0, 31584.36831263316, 34172.60791744554, 34189.31621367609, 41069.38395924004, 41111.7944410276, 41132.38301425541, 41239.793801032, 41414.792926035174, 30946.0, 31091.68908310888, 31124.377512449173, 31145.221369465944, 31247.843760781052, 30426.543601845548, 30596.541051884684, 30789.69210307958, 30816.691833081382, 31114.68885311118, 33872.830635846665, 33938.830305848314, 34043.82978085094, 34123.0, 34315.14212144716, 32629.18427039343, 33000.66999330072, 33121.0, 33191.502127467626, 33298.83350583328, 24213.636795448434, 24431.0, 24484.0, 25300.0, 25335.6199657009], "value": 17031.95535158645, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [563.8731285460769, 566.7053132371167, 571.2459553389527, 585.6427579176702, 587.5241054745655, 21158.365249042534, 21858.23496177634, 21878.0, 21935.232266870662, 22443.438914027156, 25215.2435426937, 25467.235982920494, 25505.61741573878, 25638.615420768703, 25639.0, 6460.838479038026, 6610.93389066108, 6628.304028077055, 6632.336766323353, 6638.966805165967, 5961.791337303195, 6525.3474652534605, 6537.280899101095, 6539.836504087389, 6564.081028655992, 6508.511861610375, 6508.60948343101, 6510.772122975697, 6514.8045558633075, 6536.379043990813, 6499.35006499351, 6515.055316979012, 6518.28298887122, 6519.185101862267, 6519.869602607945, 6078.3921607838865, 6082.908756368658, 6089.0866370044405, 6091.878162436771, 6092.634441933498, 28930.710692893223, 28934.42131157386, 29598.85200574005, 29703.851480742673, 29809.105726828013, 2015.5968806238811, 2072.7305450291515, 2073.067119796083, 2073.0774805211686, 2074.3258441006583, 18186.363477278363, 19153.0, 19195.904020479808, 19205.80794192068, 19215.903920480447, 2366.9408264793346, 2428.429319110008, 2430.1130087518104, 2459.8032157427365, 2504.8747562621797, 135610.0, 138662.3066884659, 139022.99999999898, 139186.0, 139260.0, 14064.226467544384, 14384.35270412834, 14392.928035359757, 14424.855751442561, 14514.85485145135, 22555.210567630384, 22666.320010399715, 22675.319740407813, 22807.543849122925, 22849.31452056441, 9717.611295548098, 10021.148202402877, 10079.445630490394, 10080.344777589433, 10097.444640544694, 7729.884051739228, 8117.878231826528, 9115.908840911507, 9230.676926307548, 9313.953430232805, 8628.22345988864, 9000.549972501349, 9017.143371379709, 9049.230815380635, 9201.907980920105, 2537.479816637585, 2554.374178326285, 2665.2404064841426, 2681.8122731408616, 2770.252031951362, 948.5921053946869, 963.1267185324616, 966.2366730283138, 967.8983706710835, 979.4123525884555, 19380.903095484715, 19391.80608193928, 19603.0, 19927.800721992593, 20195.990200489916, 1034.462079718542, 1036.0623635609786, 1038.444432228769, 1048.7535429174138, 1049.7585555322319, 10578.735531611772, 10758.56965721378, 10765.892341076646, 10973.890261097447, 11138.220324577202, 426448.0, 432027.0, 434964.0, 438648.0, 455532.0, 106582.0, 107785.0, 112150.0, 113485.43257283661, 113663.0, 1142.5772464188303, 1161.866385365677, 1163.9301641901513, 1185.3776767197292, 1186.649938268213, 17478.82521174772, 17630.73553896667, 17649.117544122484, 17974.64050718952, 18163.545911351794, 53837.0, 54659.0, 54882.45117548773, 55627.0, 56125.71937140451, 66937.0, 67145.0, 67892.660536697, 72281.27718722746, 75294.62352688202, 11667.416629168678, 12695.238285702888, 13611.251381173734, 13629.931850340685, 13722.656933576342, 20530.0, 20874.060667269707, 20889.791102088784, 21482.24812131568, 21489.0, 16772.24524896407, 16910.746338805173, 16962.236699348807, 16970.40603578869, 17042.318307268066, 15158.621034474227, 15641.0, 15799.447019354728, 15895.682086357976, 15899.920500397424, 17836.55408614795, 18287.0, 18288.81711182871, 18320.08399580042, 18343.816561834745, 13728.519501817389, 13788.793168102286, 13944.30278486092, 13965.720685586435, 13968.02223844321, 17083.316667333664, 17139.400120995706, 17340.65318693594, 17382.478525644252, 17390.869593476382], "value": 11649.614928943442, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1292.9806052909207, 1335.6794369351358, 1353.627752368098, 1357.4502326557747, 1362.64571211485, 14904.850951490482, 15058.849411505882, 15598.0, 15632.765508517381, 15638.296276667548, 15496.845031549681, 15782.84217157828, 15785.0, 15785.368585256605, 15787.0, 2782.526970415029, 2830.6603207615117, 2831.9292017699618, 2832.0512628269553, 2833.9858300708465, 2704.8377097374123, 2760.213339198329, 2771.1686494051805, 2771.8614069296455, 2776.8889244430197, 2744.341358074058, 2774.736400041993, 2781.235160330905, 2784.902528411506, 2788.8745006474655, 2733.180045986206, 2812.9296767580768, 2814.1979535832293, 2816.7183281671873, 2816.8732407041734, 2738.137486691706, 2748.4228312054493, 2749.285185851673, 2752.1055656911585, 2762.82041667293, 14871.851281487263, 15107.54677359681, 15143.167125808077, 15144.772828407582, 15148.1668508232, 8078.23256790604, 8374.623141958626, 8397.874031889527, 8401.117882622299, 8401.663933442655, 5551.333839939233, 5758.596898217126, 5932.495737862287, 5952.404759524056, 5968.582199246054, 1853.3513270355402, 1900.2304066852946, 1907.7138429235588, 1922.5866438715743, 1954.7165660979222, 26343.868280658666, 26623.600645990326, 26640.333991650168, 26949.0, 27637.861810691018, 6825.35159159879, 6903.344182302673, 6970.198427180939, 7098.574085554883, 7114.537555058904, 16199.43301984425, 16234.431794887123, 16245.0, 16246.593835153979, 16272.349106035863, 8077.27304542594, 8209.0, 8211.34309255258, 8212.46618969765, 8213.137620549756, 7536.397088232929, 7559.811004724816, 7562.281583249583, 7691.615419229016, 7692.7692169235015, 5056.924146137811, 5200.375954885438, 5245.291885595472, 5257.2639830423, 5306.044911915892, 1459.919704416246, 1478.2756449339747, 1504.6238440389902, 1506.8342482326934, 1521.0341433190003, 849.1041950741903, 870.4429165334191, 880.6213328268906, 887.0863011098579, 896.0457113174448, 7527.962360188164, 7540.472166948261, 7578.772636820904, 7623.656935437808, 7625.313721765067, 707.0596107177441, 707.4729326651677, 717.9425645948417, 718.0593422616389, 724.5652608434897, 4833.854984350475, 5239.0, 5391.78432862689, 5425.294711687456, 5440.401555828856, 21196.470088247916, 21353.25263615766, 21956.341309760413, 22083.0, 22519.54960900773, 22054.0, 22058.669119963215, 22113.55772884533, 22222.444438888833, 22235.110595575996, 9950.253730970206, 10272.486375681186, 10649.775275843222, 10683.732906677395, 10691.518881650345, 8052.436329456882, 8808.559572021246, 9207.723768286962, 9335.113164249386, 9403.764905877408, 18078.638427231646, 19053.42839714811, 19206.61586768229, 19478.61042779165, 19570.412887613395, 19768.703469448257, 19773.901130494254, 19810.40568782939, 19829.30597429083, 19901.402957911287, 12023.158378913742, 12308.199967002116, 12368.1960672556, 12387.19483233587, 12390.938045309716, 13055.543055992996, 13136.540221092217, 13218.471261149447, 13238.602841914759, 13436.059475836597, 10348.327358721961, 11025.42415045512, 11052.834207486734, 11328.886711132784, 11472.082233421474, 10926.890731092906, 11026.228164028442, 11059.391733454737, 11080.0, 11312.20814542974, 10170.79658406813, 10172.338797978107, 10211.489425528545, 10269.383836969508, 10297.53661085268, 7263.164736055422, 7306.2693730626515, 7324.523905946096, 7428.0, 7454.478186527108, 7371.0, 7399.334059934632, 7411.0, 7411.295926886937, 7504.399648028254], "value": 6693.639244102989, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [507.9949200507995, 511.205076106654, 539.4416778634112, 540.6864018869055, 545.5362941499728, 6370.840728981778, 6405.775797847076, 6476.22285325761, 6513.4789216862655, 6551.787919234933, 6156.445919867211, 6167.938320616792, 6235.220597425322, 6235.906461403071, 6326.8101956941255, 5034.01836641855, 5041.218611115283, 5102.1836506159025, 5109.131447653907, 5135.871603209912, 5056.898862022757, 5104.310918026056, 5114.7698353574, 5163.561097306715, 5184.481551844804, 4914.901701965977, 4966.304717339575, 5048.419431765357, 5077.162268225738, 5094.77073531692, 5038.521340472686, 5054.166062599704, 5056.191009438472, 5062.949370506321, 5087.643864929457, 4533.705309154927, 4541.659375546814, 4542.977285113587, 4569.95430045702, 4583.633309335279, 6246.281677607042, 6267.4672652824565, 6283.465905398047, 6290.308066112724, 6306.49548036156, 5818.883622327572, 5830.7084645767545, 5848.766049358021, 5866.9119963200155, 5901.586888917777, 6554.901676474857, 6630.6237882997475, 6675.632840193787, 6682.83292917676, 6755.898661520081, 4899.730514821684, 4949.554540091373, 4951.925721114186, 4958.9752051239875, 4987.900241995176, 7012.368886800213, 7028.472864535129, 7052.753153639598, 7093.858122837566, 7133.286671332929, 5049.823256186016, 5084.898302033938, 5093.06463543851, 5100.974495127501, 5167.741612919339, 5136.5377116059735, 5140.742962851842, 5151.562117220078, 5176.058977883294, 5199.688018718889, 5845.152452894392, 5845.590808643439, 5860.531157507389, 5865.853353666193, 5874.236349274567, 6732.9127970329355, 6753.324667533306, 6764.5603035802515, 6783.660816959133, 6819.113515242987, 1690.3745614122608, 1749.6850566897826, 1768.1159420289855, 1808.5478630342413, 1890.0, 1462.1373389700127, 1469.2580246975422, 1477.674911519464, 1479.1273148842236, 1490.3144553505292, 5827.76688932438, 5908.729623131047, 5939.584229104008, 5994.520438364921, 6005.519558435315, 6641.933580664131, 6782.287859774751, 6873.965630171817, 6889.276625954303, 6902.0, 5760.36635970043, 5824.592278540462, 5853.356130825606, 5913.231279933667, 5977.880442391128, 3584.9962010637064, 3604.819759012039, 3664.5419322584676, 3668.6514781095752, 3692.3046176290923, 6579.736810527621, 6610.471162307004, 6652.301508341651, 6664.766733164316, 6722.6302553359055, 7016.824579385556, 7052.541584796972, 7114.857702846018, 7118.430525558047, 7134.750283740044, 6555.311692272243, 6571.408573228241, 6597.175353080865, 6616.966915165393, 6644.136262285871, 6770.695318710571, 6837.897431538431, 6851.760188393382, 6885.277045910308, 6979.581225126509, 6809.127489940306, 6885.311468853075, 6923.6192009439965, 6931.123583712702, 6931.30686931323, 6588.637624930675, 6634.601923884582, 6664.5668031579735, 6664.8000559983275, 6693.19681638187, 4972.5027497249985, 5021.4225364083595, 5032.899342013213, 5088.313077734459, 5100.311457953128, 6891.138607674041, 6922.342377474132, 6929.5842249465195, 6934.722611095702, 6961.443084553122, 6563.704633291609, 6619.404253617197, 6663.800085997428, 6701.760174367758, 6748.662566871735, 6471.385218404244, 6615.791341199418, 6619.536632435684, 6683.866322673616, 6730.4952128589575, 6304.936950630435, 6323.620582765049, 6409.4231519163495, 6432.614043157426, 6570.441512471493, 6571.34286571339, 6663.36698013688, 6672.864683301297, 6696.397324240842, 6723.4285085766305, 6333.1766870306565, 6350.523710721622, 6390.073439351361, 6460.967695161682, 6491.188601424822], "value": 5185.033896508408, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [825.2984962781636, 869.4696235296464, 875.5534677314572, 911.5761171055458, 923.2198792020743, 17363.913180434098, 18109.547261318457, 18117.45647630573, 18157.636847263046, 19412.708809367836, 19892.801071989277, 20033.699494507593, 20063.79936200641, 20138.49653758657, 20323.0, 920.0385597051081, 999.8800143982733, 1000.924930630202, 1005.5123265216364, 1008.1430783833756, 959.932804703671, 1013.381837079381, 1013.6806905824642, 1014.8173328800813, 1022.9641962531313, 1049.5801679328254, 1050.4695128959866, 1050.8844027157006, 1053.1048608682597, 1053.2206167436118, 1045.4668119259156, 1048.3814549415843, 1050.1388861133873, 1051.0067985753467, 1052.7841792432532, 775.790536555127, 776.0067114093969, 776.080344791424, 776.7902666280073, 776.9689212431496, 19330.323438679578, 19625.411237662895, 19814.900925495425, 19826.80173198264, 19910.800891991184, 20886.686699699363, 21180.682289765668, 21417.14331426741, 21661.35015949524, 21671.133154673953, 16061.83938160615, 16398.180090995404, 16526.83473165277, 16590.66818663632, 16643.41748038825, 3755.380362240227, 3772.849086036555, 3774.641409066134, 3778.6032466590887, 3778.754380965256, 125054.0, 125959.3702031484, 126517.0, 126631.0, 128317.0, 16537.586560336087, 16683.249253783608, 16886.324547017983, 17051.744223836653, 17144.0, 30145.547816782764, 30261.546076808867, 30455.543166852516, 30498.237544061132, 30556.69443305583, 7118.145822501333, 7401.5189012714, 8429.283510901641, 8593.914060859312, 8607.311415086779, 3639.1266096137265, 4073.837046518165, 4257.297545904953, 4270.402143699885, 4277.657787377002, 5101.413337466239, 5211.0359583477175, 5234.869128271824, 5240.816571419982, 5267.683938963674, 1062.2882668612049, 1069.9465026748787, 1083.9458027098613, 1085.2999815119363, 1087.5160553553592, 657.9407853293227, 679.9864002720017, 683.6308393467572, 685.5098604497808, 692.8856738638068, 11293.943530282297, 11437.559294951749, 11890.821637675443, 12384.256944583354, 12695.42870570808, 659.9406053455212, 669.4744625468984, 670.6553360512142, 684.7158429251905, 686.1765880942788, 5506.587005974568, 5536.889262214733, 5626.099824028136, 5642.98426283273, 5662.688552129673, 106453.0, 106598.0, 108216.0, 109619.35570966442, 111205.0, 91735.0, 91780.0, 91819.0, 94649.5267523658, 98172.50913745386, 80121.0, 81838.18161818424, 84392.57803710942, 85825.0, 85994.0, 10903.563857445613, 12110.878891210976, 12159.452824622736, 12268.0, 12361.134720569475, 39854.0, 40555.79722101489, 41564.0, 41812.372814408416, 42867.356989644555, 52916.73541632421, 53839.730801345744, 54765.726171368886, 55009.449905500434, 55771.72114139403, 16270.837291626933, 16633.83366166323, 16694.916525417295, 16767.91616041912, 16788.160591970107, 19316.227350906367, 19488.512787179865, 19613.31353402624, 19686.90156549208, 19693.606127877076, 17524.737128943332, 17697.734533982257, 17706.114694265492, 17748.733768993734, 17816.643667126846, 16979.830201697823, 17133.485995420157, 17204.225809838837, 17262.82737172612, 17420.651586968444, 15936.601584960468, 16120.758188626945, 16126.2743176555, 16203.108829014518, 16209.432669856498, 13177.27524986135, 13571.0, 13622.523211687543, 13685.31573421305, 13968.161910285415, 13284.867151328363, 13296.135751176529, 13339.66650833737, 13358.933205333911, 13428.731425371634], "value": 8937.909728700595, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1481.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 108.0, 95.0, 106.0, 107.0, 108.0, 110.0, 107.0, 108.0, 108.0], "value": 106.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 116.0, 148.0, 180.0, 117.0, 147.0, 144.0, 118.0, 168.0, 118.0], "value": 139.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 163.0, 164.0, 164.0, 163.0, 166.0, 170.0, 164.0, 166.0], "value": 164.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 73.0, 184.0, 76.0, 76.0, 76.0, 73.0, 157.0, 76.0], "value": 93.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 78.0, 134.0, 79.0, 79.0, 79.0, 125.0, 78.0, 79.0, 129.0], "value": 94.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 115.0, 115.0, 114.0, 113.0, 114.0, 113.0, 115.0, 113.0], "value": 114.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 147.0, 148.0, 148.0, 147.0, 148.0, 147.0, 148.0, 147.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 93.0, 93.0, 101.0, 93.0, 94.0, 93.0, 95.0, 94.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 53.0, 53.0, 52.0, 54.0, 52.0, 53.0, 52.0, 53.0, 52.0], "value": 52.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 39.0, 38.0, 39.0, 38.0], "value": 38.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 75.0, 78.0, 75.0, 75.0, 77.0, 75.0, 74.0, 75.0], "value": 75.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 129.0, 120.0, 121.0, 130.0, 119.0, 116.0, 116.0, 118.0, 159.0], "value": 125.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 172.0, 171.0, 169.0, 172.0, 177.0, 170.0, 169.0, 168.0, 169.0], "value": 170.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 66.0, 64.0, 68.0, 63.0, 64.0, 65.0, 64.0, 66.0], "value": 65.0, "unit": "score"}]}]} 03:35:44 INFO - Return code: 0 03:35:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:35:44 INFO - # TBPL SUCCESS # 03:35:44 INFO - Running post-action listener: _package_coverage_data 03:35:44 INFO - Running post-action listener: _resource_record_post_action 03:35:44 INFO - [mozharness: 2017-09-04 10:35:44.406773Z] Finished run-tests step (success) 03:35:44 INFO - Running post-run listener: _resource_record_post_run 03:35:44 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 49152; Write bytes: 401829888; Read time: 404; Write time: 255448 03:35:44 INFO - TinderboxPrint: CPU usage
13.1% 03:35:44 INFO - TinderboxPrint: I/O read bytes / time
49,152 / 404 03:35:44 INFO - TinderboxPrint: I/O write bytes / time
401,829,888 / 255,448 03:35:44 INFO - TinderboxPrint: CPU idle
8,245.6 (86.9%) 03:35:44 INFO - TinderboxPrint: CPU user
1,193.5 (12.6%) 03:35:44 INFO - TinderboxPrint: Swap in / out
0 / 0 03:35:44 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 116879360; Read time: 188; Write time: 92760 03:35:44 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:35:44 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 45056; Write bytes: 284123136; Read time: 216; Write time: 162612 03:35:45 INFO - Running post-run listener: _upload_blobber_files 03:35:45 INFO - Blob upload gear active. 03:35:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:35:45 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 03:35:45 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'] 03:35:45 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 03:35:45 INFO - (blobuploader) - INFO - Open directory for files ... 03:35:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:35:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:35:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:35:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:35:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:35:48 INFO - (blobuploader) - INFO - Done attempting. 03:35:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:35:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:35:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:35:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:35:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:35:49 INFO - (blobuploader) - INFO - Done attempting. 03:35:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:35:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:35:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:35:51 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:35:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:35:51 INFO - (blobuploader) - INFO - Done attempting. 03:35:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:35:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:35:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:35:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:35:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:35:52 INFO - (blobuploader) - INFO - Done attempting. 03:35:52 INFO - (blobuploader) - INFO - Iteration through files over. 03:35:52 INFO - Return code: 0 03:35:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:35:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:35:52 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d3467a56b889e9cb5db0a61790a6ea17126ef8ae0912cc871f8d0f3e18224cff5099112da0b28a2e912e8b0ec4563be706d942fe9b2348673446b8a9b142f710", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d92748d462a04df802a4e17937535caf6417cd9233d16a50e9b0ba86aa8fe6e2642b4c9a19f57a211628ad3e78c23ac3bc0ae96723a3a7ec710a56780a8c0c33", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b0a34d33047b6874c02ba30f164c73edca02116cc9662a78224789958bb0260f361e573cda9590ddebb0f3727ca060a90ded5b434f558802aad8c5c5c81c1915", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4d2b1371501059295541ab68fe73fa526609fdec015bd9cee7fd64aa4d605262ac1528a4bc8f6e079c781bad8e8f8a332881928207d5c62e3615d7b12b2f97ee"} 03:35:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:35:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:35:52 INFO - Contents: 03:35:52 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d3467a56b889e9cb5db0a61790a6ea17126ef8ae0912cc871f8d0f3e18224cff5099112da0b28a2e912e8b0ec4563be706d942fe9b2348673446b8a9b142f710", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d92748d462a04df802a4e17937535caf6417cd9233d16a50e9b0ba86aa8fe6e2642b4c9a19f57a211628ad3e78c23ac3bc0ae96723a3a7ec710a56780a8c0c33", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b0a34d33047b6874c02ba30f164c73edca02116cc9662a78224789958bb0260f361e573cda9590ddebb0f3727ca060a90ded5b434f558802aad8c5c5c81c1915", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4d2b1371501059295541ab68fe73fa526609fdec015bd9cee7fd64aa4d605262ac1528a4bc8f6e079c781bad8e8f8a332881928207d5c62e3615d7b12b2f97ee"} 03:35:52 INFO - Running post-run listener: copy_logs_to_upload_dir 03:35:52 INFO - Copying logs to upload dir... 03:35:52 INFO - mkdir: /builds/slave/test/build/upload/logs 03:35:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.613483 ========= master_lag: 0.09 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-09-04 03:35:52.307279) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-04 03:35:52.311760) ========= 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=32c5991c409366f7fec8a718000001d2-1504520097.981278-666853037 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d3467a56b889e9cb5db0a61790a6ea17126ef8ae0912cc871f8d0f3e18224cff5099112da0b28a2e912e8b0ec4563be706d942fe9b2348673446b8a9b142f710", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d92748d462a04df802a4e17937535caf6417cd9233d16a50e9b0ba86aa8fe6e2642b4c9a19f57a211628ad3e78c23ac3bc0ae96723a3a7ec710a56780a8c0c33", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b0a34d33047b6874c02ba30f164c73edca02116cc9662a78224789958bb0260f361e573cda9590ddebb0f3727ca060a90ded5b434f558802aad8c5c5c81c1915", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4d2b1371501059295541ab68fe73fa526609fdec015bd9cee7fd64aa4d605262ac1528a4bc8f6e079c781bad8e8f8a332881928207d5c62e3615d7b12b2f97ee"} build_url:https://queue.taskcluster.net/v1/task/ZH0GnAa4QqyzRlNalh5SXw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011294 build_url: 'https://queue.taskcluster.net/v1/task/ZH0GnAa4QqyzRlNalh5SXw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d3467a56b889e9cb5db0a61790a6ea17126ef8ae0912cc871f8d0f3e18224cff5099112da0b28a2e912e8b0ec4563be706d942fe9b2348673446b8a9b142f710", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d92748d462a04df802a4e17937535caf6417cd9233d16a50e9b0ba86aa8fe6e2642b4c9a19f57a211628ad3e78c23ac3bc0ae96723a3a7ec710a56780a8c0c33", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b0a34d33047b6874c02ba30f164c73edca02116cc9662a78224789958bb0260f361e573cda9590ddebb0f3727ca060a90ded5b434f558802aad8c5c5c81c1915", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4d2b1371501059295541ab68fe73fa526609fdec015bd9cee7fd64aa4d605262ac1528a4bc8f6e079c781bad8e8f8a332881928207d5c62e3615d7b12b2f97ee"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-04 03:35:52.342830) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-04 03:35:52.343160) ========= 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=32c5991c409366f7fec8a718000001d2-1504520097.981278-666853037 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004485 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-04 03:35:52.426303) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-04 03:35:52.426623) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-04 03:35:52.426966) ========= ========= Total master_lag: 0.26 =========