builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-025 starttime: 1503708010.69 results: success (0) revision: 86a3c73984a23b1d524eadbd4a62b9b3fa27e46a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-25 17:40:10.686664) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-25 17:40:10.687196) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-25 17:40:10.687472) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-25 17:40:10.706872) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-25 17:40:10.707239) ========= 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=232498196343f89f466a4a9a000001c8-1503708009.729582-841113133 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-25 17:40:10-- 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% 111M=0s 2017-08-25 17:40:10 (111 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.119072 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-25 17:40:10.841609) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-25 17:40:10.841915) ========= 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=232498196343f89f466a4a9a000001c8-1503708009.729582-841113133 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016775 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-25 17:40:10.894936) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-25 17:40:10.898283) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 86a3c73984a23b1d524eadbd4a62b9b3fa27e46a --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 86a3c73984a23b1d524eadbd4a62b9b3fa27e46a --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=232498196343f89f466a4a9a000001c8-1503708009.729582-841113133 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-25 17:40:11,068 truncating revision to first 12 chars 2017-08-25 17:40:11,068 Setting DEBUG logging. 2017-08-25 17:40:11,068 attempt 1/10 2017-08-25 17:40:11,068 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/86a3c73984a2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-25 17:40:11,636 unpacking tar archive at: mozilla-central-86a3c73984a2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.927744 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-25 17:40:11.843707) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-25 17:40:11.844026) ========= script_repo_revision: 86a3c73984a23b1d524eadbd4a62b9b3fa27e46a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-25 17:40:11.844427) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-25 17:40:11.844689) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-25 17:40:11.856717) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-08-25 17:40:11.857004) ========= /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=232498196343f89f466a4a9a000001c8-1503708009.729582-841113133 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:40:12 INFO - MultiFileLogger online at 20170825 17:40:12 in /builds/slave/test 17:40:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 17:40:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:40:12 INFO - {'append_to_log': False, 17:40:12 INFO - 'base_work_dir': '/builds/slave/test', 17:40:12 INFO - 'blob_upload_branch': 'Firefox', 17:40:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:40:12 INFO - 'branch': 'Firefox', 17:40:12 INFO - 'buildbot_json_path': 'buildprops.json', 17:40:12 INFO - 'code_coverage': False, 17:40:12 INFO - 'config_files': ('talos/linux_config.py',), 17:40:12 INFO - 'default_actions': ('clobber', 17:40:12 INFO - 'read-buildbot-config', 17:40:12 INFO - 'download-and-extract', 17:40:12 INFO - 'populate-webroot', 17:40:12 INFO - 'create-virtualenv', 17:40:12 INFO - 'install', 17:40:12 INFO - 'setup-mitmproxy', 17:40:12 INFO - 'run-tests'), 17:40:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:40:12 INFO - 'disable_ccov_upload': False, 17:40:12 INFO - 'download_minidump_stackwalk': True, 17:40:12 INFO - 'download_symbols': 'ondemand', 17:40:12 INFO - 'enable_stylo': False, 17:40:12 INFO - 'enable_webrender': False, 17:40:12 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 17:40:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:40:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:40:12 INFO - 'gecko_profile': False, 17:40:12 INFO - 'gecko_profile_interval': 0, 17:40:12 INFO - 'installer_path': 'installer.exe', 17:40:12 INFO - 'log_level': 'info', 17:40:12 INFO - 'log_name': 'talos', 17:40:12 INFO - 'log_to_console': True, 17:40:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:40:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:40:12 INFO - 'opt_config_files': (), 17:40:12 INFO - 'pip_index': False, 17:40:12 INFO - 'suite': 'dromaeojs-e10s', 17:40:12 INFO - 'system_bits': '32', 17:40:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:40:12 INFO - 'title': 'talos-linux64-ix-025', 17:40:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:40:12 INFO - 'use_talos_json': True, 17:40:12 INFO - 'verify': 'False', 17:40:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:40:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:40:12 INFO - 'work_dir': 'build'} 17:40:12 INFO - [mozharness: 2017-08-26 00:40:12.164540Z] Running clobber step. 17:40:12 INFO - Running pre-action listener: _resource_record_pre_action 17:40:12 INFO - Running main action method: clobber 17:40:12 INFO - rmtree: /builds/slave/test/build 17:40:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:40:13 INFO - Running post-action listener: _resource_record_post_action 17:40:13 INFO - [mozharness: 2017-08-26 00:40:13.778415Z] Finished clobber step (success) 17:40:13 INFO - [mozharness: 2017-08-26 00:40:13.778512Z] Running read-buildbot-config step. 17:40:13 INFO - Running pre-action listener: _resource_record_pre_action 17:40:13 INFO - Running main action method: read_buildbot_config 17:40:13 INFO - Using buildbot properties: 17:40:13 INFO - { 17:40:13 INFO - "project": "", 17:40:13 INFO - "product": "firefox", 17:40:13 INFO - "who": "kwierso@gmail.com", 17:40:13 INFO - "installer_path": "public/build/target.tar.bz2", 17:40:13 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 17:40:13 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 17:40:13 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 17:40:13 INFO - "stage_platform": "linux64-pgo", 17:40:13 INFO - "basedir": "/builds/slave/test", 17:40:13 INFO - "buildnumber": 128, 17:40:13 INFO - "platform": "ubuntu64_hw", 17:40:13 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:40:13 INFO - "slavebuilddir": "test", 17:40:13 INFO - "taskId": "Lvp5qDBpQUKzhRfcrcCg4Q", 17:40:13 INFO - "branch": "mozilla-central", 17:40:13 INFO - "script_repo_revision": "production", 17:40:13 INFO - "revision": "86a3c73984a23b1d524eadbd4a62b9b3fa27e46a", 17:40:13 INFO - "slavename": "talos-linux64-ix-025", 17:40:13 INFO - "repo_path": "mozilla-central" 17:40:13 INFO - } 17:40:13 INFO - Finding installer, test and symbols from parent task. 17:40:13 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Lvp5qDBpQUKzhRfcrcCg4Q'}, attempt #1 17:40:14 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Lvp5qDBpQUKzhRfcrcCg4Q'}, attempt #1 17:40:14 INFO - Task dependencies: WU6AbHM2QRaABo2Jy31ApA 17:40:14 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WU6AbHM2QRaABo2Jy31ApA'}, attempt #1 17:40:15 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/WU6AbHM2QRaABo2Jy31ApA/artifacts/public/build/target.tar.bz2 17:40:15 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/WU6AbHM2QRaABo2Jy31ApA/artifacts/public/build/target.test_packages.json 17:40:15 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/WU6AbHM2QRaABo2Jy31ApA/artifacts/public/build/target.crashreporter-symbols.zip 17:40:15 INFO - Running post-action listener: _resource_record_post_action 17:40:15 INFO - [mozharness: 2017-08-26 00:40:15.167999Z] Finished read-buildbot-config step (success) 17:40:15 INFO - [mozharness: 2017-08-26 00:40:15.168216Z] Running download-and-extract step. 17:40:15 INFO - Running pre-action listener: _resource_record_pre_action 17:40:15 INFO - Running main action method: download_and_extract 17:40:15 INFO - mkdir: /builds/slave/test/build/tests 17:40:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:40:15 INFO - trying https://queue.taskcluster.net/v1/task/WU6AbHM2QRaABo2Jy31ApA/artifacts/public/build/target.test_packages.json 17:40:15 INFO - Downloading https://queue.taskcluster.net/v1/task/WU6AbHM2QRaABo2Jy31ApA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 17:40:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WU6AbHM2QRaABo2Jy31ApA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 17:40:15 INFO - Downloaded 989 bytes. 17:40:15 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 17:40:15 INFO - Using the following test package requirements: 17:40:15 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 17:40:15 INFO - u'common': [u'target.common.tests.zip'], 17:40:15 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 17:40:15 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 17:40:15 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 17:40:15 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 17:40:15 INFO - u'mozbase': [u'target.common.tests.zip'], 17:40:15 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 17:40:15 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 17:40:15 INFO - u'web-platform': [u'target.common.tests.zip', 17:40:15 INFO - u'target.web-platform.tests.tar.gz'], 17:40:15 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 17:40:15 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 17:40:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WU6AbHM2QRaABo2Jy31ApA/artifacts/public/build/target.common.tests.zip 17:40:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WU6AbHM2QRaABo2Jy31ApA/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:40:15 INFO - Fetch https://queue.taskcluster.net/v1/task/WU6AbHM2QRaABo2Jy31ApA/artifacts/public/build/target.common.tests.zip into memory 17:40:16 INFO - Content-Length response header: 55736482 17:40:16 INFO - Bytes received: 55736482 17:40:27 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 17:40:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WU6AbHM2QRaABo2Jy31ApA/artifacts/public/build/target.common.tests.zip 17:40:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WU6AbHM2QRaABo2Jy31ApA/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:40:27 INFO - Fetch https://queue.taskcluster.net/v1/task/WU6AbHM2QRaABo2Jy31ApA/artifacts/public/build/target.common.tests.zip into memory 17:40:29 INFO - Content-Length response header: 55736482 17:40:29 INFO - Bytes received: 55736482 17:40:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WU6AbHM2QRaABo2Jy31ApA/artifacts/public/build/target.talos.tests.zip 17:40:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WU6AbHM2QRaABo2Jy31ApA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 17:40:41 INFO - Fetch https://queue.taskcluster.net/v1/task/WU6AbHM2QRaABo2Jy31ApA/artifacts/public/build/target.talos.tests.zip into memory 17:40:41 INFO - Content-Length response header: 14496611 17:40:41 INFO - Bytes received: 14496611 17:40:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:40:42 INFO - trying https://queue.taskcluster.net/v1/task/WU6AbHM2QRaABo2Jy31ApA/artifacts/public/build/target.tar.bz2 17:40:42 INFO - Downloading https://queue.taskcluster.net/v1/task/WU6AbHM2QRaABo2Jy31ApA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 17:40:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WU6AbHM2QRaABo2Jy31ApA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 17:40:43 INFO - Downloaded 62290356 bytes. 17:40:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WU6AbHM2QRaABo2Jy31ApA/artifacts/public/build/target.tar.bz2 17:40:43 INFO - mkdir: /builds/slave/test/properties 17:40:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:40:43 INFO - Writing to file /builds/slave/test/properties/build_url 17:40:43 INFO - Contents: 17:40:43 INFO - build_url:https://queue.taskcluster.net/v1/task/WU6AbHM2QRaABo2Jy31ApA/artifacts/public/build/target.tar.bz2 17:40:43 INFO - Running post-action listener: _resource_record_post_action 17:40:43 INFO - Running post-action listener: find_tests_for_verification 17:40:43 INFO - Running post-action listener: set_extra_try_arguments 17:40:43 INFO - [mozharness: 2017-08-26 00:40:43.238248Z] Finished download-and-extract step (success) 17:40:43 INFO - [mozharness: 2017-08-26 00:40:43.238345Z] Running populate-webroot step. 17:40:43 INFO - Running pre-action listener: _resource_record_pre_action 17:40:43 INFO - Running main action method: populate_webroot 17:40:43 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:40:43 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 17:40:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:40:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:40:43 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 17:40:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:40:43 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:40:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:40:43 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:40:43 INFO - 'talos_options': ['--stylo'], 17:40:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:40:43 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:40:43 INFO - 'tests': ['damp', 'tps']}, 17:40:43 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:40:43 INFO - 'talos_options': ['--stylo'], 17:40:43 INFO - 'tests': ['damp', 'tps']}, 17:40:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:40:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 17:40:43 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 17:40:43 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 17:40:43 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 17:40:43 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 17:40:43 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:40:43 INFO - 'talos_options': ['--stylo'], 17:40:43 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 17:40:43 INFO - 'other-e10s': {'tests': ['a11yr', 17:40:43 INFO - 'ts_paint', 17:40:43 INFO - 'tpaint', 17:40:43 INFO - 'sessionrestore', 17:40:43 INFO - 'sessionrestore_many_windows', 17:40:43 INFO - 'sessionrestore_no_auto_restore', 17:40:43 INFO - 'tabpaint']}, 17:40:43 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 17:40:43 INFO - 'tests': ['a11yr', 17:40:43 INFO - 'ts_paint', 17:40:43 INFO - 'tpaint', 17:40:43 INFO - 'sessionrestore', 17:40:43 INFO - 'sessionrestore_many_windows', 17:40:43 INFO - 'sessionrestore_no_auto_restore', 17:40:43 INFO - 'tabpaint']}, 17:40:43 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 17:40:43 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 17:40:43 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 17:40:43 INFO - 'tests': ['bloom_basic_singleton']}, 17:40:43 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 17:40:43 INFO - 'tests': ['bloom_basic']}, 17:40:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:40:43 INFO - 'tsvgr_opacity', 17:40:43 INFO - 'tart', 17:40:43 INFO - 'tscrollx', 17:40:43 INFO - 'tsvg_static']}, 17:40:43 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 17:40:43 INFO - 'tests': ['tsvgx', 17:40:43 INFO - 'tsvgr_opacity', 17:40:43 INFO - 'tart', 17:40:43 INFO - 'tscrollx', 17:40:43 INFO - 'tsvg_static']}, 17:40:43 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:40:43 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:40:43 INFO - 'talos_options': ['--stylo'], 17:40:43 INFO - 'tests': ['tp5o']}, 17:40:43 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:40:43 INFO - 'talos_options': ['--mitmproxy', 17:40:43 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:40:43 INFO - '--firstNonBlankPaint'], 17:40:43 INFO - 'tests': ['tp6_google', 17:40:43 INFO - 'tp6_youtube', 17:40:43 INFO - 'tp6_amazon', 17:40:43 INFO - 'tp6_facebook']}, 17:40:43 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:40:43 INFO - 'talos_options': ['--stylo', 17:40:43 INFO - '--mitmproxy', 17:40:43 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:40:43 INFO - '--firstNonBlankPaint'], 17:40:43 INFO - 'tests': ['tp6_google', 17:40:43 INFO - 'tp6_youtube', 17:40:43 INFO - 'tp6_amazon', 17:40:43 INFO - 'tp6_facebook']}, 17:40:43 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:40:43 INFO - 'talos_options': ['--stylo', 17:40:43 INFO - '--stylo-threads=1', 17:40:43 INFO - '--mitmproxy', 17:40:43 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:40:43 INFO - '--firstNonBlankPaint'], 17:40:43 INFO - 'tests': ['tp6_google', 17:40:43 INFO - 'tp6_youtube', 17:40:43 INFO - 'tp6_amazon', 17:40:43 INFO - 'tp6_facebook']}, 17:40:43 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:40:43 INFO - 'talos_options': ['--xperf_path', 17:40:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:40:43 INFO - 'tests': ['tp5n']}, 17:40:43 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:40:43 INFO - 'talos_options': ['--stylo', 17:40:43 INFO - '--xperf_path', 17:40:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:40:43 INFO - 'tests': ['tp5n']}}} 17:40:43 INFO - Running post-action listener: _resource_record_post_action 17:40:43 INFO - [mozharness: 2017-08-26 00:40:43.252473Z] Finished populate-webroot step (success) 17:40:43 INFO - [mozharness: 2017-08-26 00:40:43.252563Z] Running create-virtualenv step. 17:40:43 INFO - Running pre-action listener: _resource_record_pre_action 17:40:43 INFO - Running main action method: create_virtualenv 17:40:43 INFO - Creating virtualenv /builds/slave/test/build/venv 17:40:43 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:40:43 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 17:40:43 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 17:40:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:40:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:40:43 INFO - Installing distribute.............................................................................................................................................................................................done. 17:40:44 INFO - Installing pip...............done. 17:40:44 INFO - Return code: 0 17:40:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:40:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:40:44 INFO - Reading from file tmpfile_stdout 17:40:44 INFO - Output received: 17:40:44 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 17:40:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:40: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')]} 17:40:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:40: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')]} 17:40:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:40:44 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 0xdd81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1146f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1144130>, '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 0x1145030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11454c0>, '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': '232498196343f89f466a4a9a000001c8-1503708009.729582-841113133', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:40:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:40:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:40:44 INFO - Using env: {'DISPLAY': ':0', 17:40:44 INFO - 'HOME': '/home/cltbld', 17:40:44 INFO - 'LANG': 'en_US.UTF-8', 17:40:44 INFO - 'LANGUAGE': 'en_US:en', 17:40:44 INFO - 'LOGNAME': 'cltbld', 17:40:44 INFO - 'MAIL': '/var/mail/cltbld', 17:40:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:40:44 INFO - 'MOZ_NO_REMOTE': '1', 17:40:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:40:44 INFO - 'NO_EM_RESTART': '1', 17:40:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:40:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:40:44 INFO - 'PWD': '/builds/slave/test', 17:40:44 INFO - 'SHELL': '/bin/bash', 17:40:44 INFO - 'SHLVL': '1', 17:40:44 INFO - 'TERM': 'linux', 17:40:44 INFO - 'TMOUT': '86400', 17:40:44 INFO - 'USER': 'cltbld', 17:40:44 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1503708009.729582-841113133', 17:40:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:40:44 INFO - '_': '/tools/buildbot/bin/python'} 17:40:45 INFO - Ignoring indexes: http://pypi.python.org/simple/ 17:40:45 INFO - Downloading/unpacking pip>=1.5 17:40:45 INFO - Running setup.py egg_info for package pip 17:40:45 INFO - warning: no files found matching 'pip/cacert.pem' 17:40:45 INFO - warning: no files found matching '*.html' under directory 'docs' 17:40:45 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 17:40:45 INFO - no previously-included directories found matching 'docs/_build/_sources' 17:40:45 INFO - Installing collected packages: pip 17:40:45 INFO - Found existing installation: pip 1.1 17:40:45 INFO - Uninstalling pip: 17:40:45 INFO - Successfully uninstalled pip 17:40:45 INFO - Running setup.py install for pip 17:40:45 INFO - warning: no files found matching 'pip/cacert.pem' 17:40:45 INFO - warning: no files found matching '*.html' under directory 'docs' 17:40:45 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 17:40:45 INFO - no previously-included directories found matching 'docs/_build/_sources' 17:40:45 INFO - Installing pip script to /builds/slave/test/build/venv/bin 17:40:45 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 17:40:45 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 17:40:45 INFO - Successfully installed pip 17:40:45 INFO - Cleaning up... 17:40:45 INFO - Return code: 0 17:40:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:40:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:40:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:40:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:40:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:40:45 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 0xdd81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1146f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1144130>, '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 0x1145030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11454c0>, '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': '232498196343f89f466a4a9a000001c8-1503708009.729582-841113133', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:40:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:40:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:40:45 INFO - Using env: {'DISPLAY': ':0', 17:40:45 INFO - 'HOME': '/home/cltbld', 17:40:45 INFO - 'LANG': 'en_US.UTF-8', 17:40:45 INFO - 'LANGUAGE': 'en_US:en', 17:40:45 INFO - 'LOGNAME': 'cltbld', 17:40:45 INFO - 'MAIL': '/var/mail/cltbld', 17:40:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:40:45 INFO - 'MOZ_NO_REMOTE': '1', 17:40:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:40:45 INFO - 'NO_EM_RESTART': '1', 17:40:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:40:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:40:45 INFO - 'PWD': '/builds/slave/test', 17:40:45 INFO - 'SHELL': '/bin/bash', 17:40:45 INFO - 'SHLVL': '1', 17:40:45 INFO - 'TERM': 'linux', 17:40:45 INFO - 'TMOUT': '86400', 17:40:45 INFO - 'USER': 'cltbld', 17:40:45 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1503708009.729582-841113133', 17:40:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:40:45 INFO - '_': '/tools/buildbot/bin/python'} 17:40:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:40:45 INFO - Downloading/unpacking psutil>=3.1.1 17:40:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:40:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:40:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:40:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:40:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:40:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:40:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:40:46 INFO - Installing collected packages: psutil 17:40:46 INFO - Running setup.py install for psutil 17:40:46 INFO - building 'psutil._psutil_linux' extension 17:40:46 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 17:40:47 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 17:40:47 INFO - building 'psutil._psutil_posix' extension 17:40:47 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 17:40:47 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 17:40:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:40:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:40:47 INFO - Successfully installed psutil 17:40:47 INFO - Cleaning up... 17:40:47 INFO - Return code: 0 17:40:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:40: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')]} 17:40:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:40: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')]} 17:40:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:40:47 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 0xdd81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1146f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1144130>, '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 0x1145030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11454c0>, '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': '232498196343f89f466a4a9a000001c8-1503708009.729582-841113133', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:40:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:40:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:40:47 INFO - Using env: {'DISPLAY': ':0', 17:40:47 INFO - 'HOME': '/home/cltbld', 17:40:47 INFO - 'LANG': 'en_US.UTF-8', 17:40:47 INFO - 'LANGUAGE': 'en_US:en', 17:40:47 INFO - 'LOGNAME': 'cltbld', 17:40:47 INFO - 'MAIL': '/var/mail/cltbld', 17:40:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:40:47 INFO - 'MOZ_NO_REMOTE': '1', 17:40:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:40:47 INFO - 'NO_EM_RESTART': '1', 17:40:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:40:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:40:47 INFO - 'PWD': '/builds/slave/test', 17:40:47 INFO - 'SHELL': '/bin/bash', 17:40:47 INFO - 'SHLVL': '1', 17:40:47 INFO - 'TERM': 'linux', 17:40:47 INFO - 'TMOUT': '86400', 17:40:47 INFO - 'USER': 'cltbld', 17:40:47 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1503708009.729582-841113133', 17:40:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:40:47 INFO - '_': '/tools/buildbot/bin/python'} 17:40:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:40:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:40:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:40:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:40:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:40:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:40:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:40:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:40:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:40:48 INFO - Installing collected packages: mozsystemmonitor 17:40:48 INFO - Running setup.py install for mozsystemmonitor 17:40:48 INFO - Successfully installed mozsystemmonitor 17:40:48 INFO - Cleaning up... 17:40:48 INFO - Return code: 0 17:40:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:40:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:40:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:40:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:40:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:40:48 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 0xdd81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1146f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1144130>, '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 0x1145030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11454c0>, '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': '232498196343f89f466a4a9a000001c8-1503708009.729582-841113133', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:40:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:40:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:40:48 INFO - Using env: {'DISPLAY': ':0', 17:40:48 INFO - 'HOME': '/home/cltbld', 17:40:48 INFO - 'LANG': 'en_US.UTF-8', 17:40:48 INFO - 'LANGUAGE': 'en_US:en', 17:40:48 INFO - 'LOGNAME': 'cltbld', 17:40:48 INFO - 'MAIL': '/var/mail/cltbld', 17:40:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:40:48 INFO - 'MOZ_NO_REMOTE': '1', 17:40:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:40:48 INFO - 'NO_EM_RESTART': '1', 17:40:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:40:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:40:48 INFO - 'PWD': '/builds/slave/test', 17:40:48 INFO - 'SHELL': '/bin/bash', 17:40:48 INFO - 'SHLVL': '1', 17:40:48 INFO - 'TERM': 'linux', 17:40:48 INFO - 'TMOUT': '86400', 17:40:48 INFO - 'USER': 'cltbld', 17:40:48 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1503708009.729582-841113133', 17:40:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:40:48 INFO - '_': '/tools/buildbot/bin/python'} 17:40:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:40:49 INFO - Downloading/unpacking jsonschema==2.5.1 17:40:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:40:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:40:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:40:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:40:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:40:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:40: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 17:40: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 17:40: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 17:40: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 17:40:50 INFO - Downloading functools32-3.2.3-2.tar.gz 17:40:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:40:50 INFO - warning: no files found matching '*.txt' 17:40:50 INFO - no previously-included directories found matching 'build' 17:40:50 INFO - no previously-included directories found matching 'dist' 17:40:50 INFO - no previously-included directories found matching '.git*' 17:40:50 INFO - Installing collected packages: jsonschema, functools32 17:40:50 INFO - Running setup.py install for functools32 17:40:50 INFO - warning: no files found matching '*.txt' 17:40:50 INFO - no previously-included directories found matching 'build' 17:40:50 INFO - no previously-included directories found matching 'dist' 17:40:50 INFO - no previously-included directories found matching '.git*' 17:40:50 INFO - Successfully installed jsonschema functools32 17:40:50 INFO - Cleaning up... 17:40:50 INFO - Return code: 0 17:40:50 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:40: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')]} 17:40:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:40: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')]} 17:40:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:40:50 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 0xdd81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1146f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1144130>, '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 0x1145030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11454c0>, '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': '232498196343f89f466a4a9a000001c8-1503708009.729582-841113133', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:40:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:40:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 17:40:50 INFO - Using env: {'DISPLAY': ':0', 17:40:50 INFO - 'HOME': '/home/cltbld', 17:40:50 INFO - 'LANG': 'en_US.UTF-8', 17:40:50 INFO - 'LANGUAGE': 'en_US:en', 17:40:50 INFO - 'LOGNAME': 'cltbld', 17:40:50 INFO - 'MAIL': '/var/mail/cltbld', 17:40:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:40:50 INFO - 'MOZ_NO_REMOTE': '1', 17:40:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:40:50 INFO - 'NO_EM_RESTART': '1', 17:40:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:40:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:40:50 INFO - 'PWD': '/builds/slave/test', 17:40:50 INFO - 'SHELL': '/bin/bash', 17:40:50 INFO - 'SHLVL': '1', 17:40:50 INFO - 'TERM': 'linux', 17:40:50 INFO - 'TMOUT': '86400', 17:40:50 INFO - 'USER': 'cltbld', 17:40:50 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1503708009.729582-841113133', 17:40:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:40:50 INFO - '_': '/tools/buildbot/bin/python'} 17:40:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:40:50 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:40:50 INFO - Cleaning up... 17:40:50 INFO - Return code: 0 17:40:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:40: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')]} 17:40:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:40: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')]} 17:40:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:40:50 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 0xdd81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1146f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1144130>, '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 0x1145030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11454c0>, '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': '232498196343f89f466a4a9a000001c8-1503708009.729582-841113133', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:40:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:40:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:40:50 INFO - Using env: {'DISPLAY': ':0', 17:40:50 INFO - 'HOME': '/home/cltbld', 17:40:50 INFO - 'LANG': 'en_US.UTF-8', 17:40:50 INFO - 'LANGUAGE': 'en_US:en', 17:40:50 INFO - 'LOGNAME': 'cltbld', 17:40:50 INFO - 'MAIL': '/var/mail/cltbld', 17:40:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:40:50 INFO - 'MOZ_NO_REMOTE': '1', 17:40:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:40:50 INFO - 'NO_EM_RESTART': '1', 17:40:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:40:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:40:50 INFO - 'PWD': '/builds/slave/test', 17:40:50 INFO - 'SHELL': '/bin/bash', 17:40:50 INFO - 'SHLVL': '1', 17:40:50 INFO - 'TERM': 'linux', 17:40:50 INFO - 'TMOUT': '86400', 17:40:50 INFO - 'USER': 'cltbld', 17:40:50 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1503708009.729582-841113133', 17:40:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:40:50 INFO - '_': '/tools/buildbot/bin/python'} 17:40:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:40:50 INFO - Downloading/unpacking blobuploader==1.2.4 17:40: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 17:40: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 17:40: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 17:40: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 17:40:52 INFO - Downloading blobuploader-1.2.4.tar.gz 17:40:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:40:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:40:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:40:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:40:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:40:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:40:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:40:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:40:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:40:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:40:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:40:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:40:52 INFO - Downloading docopt-0.6.1.tar.gz 17:40:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:40:52 INFO - Installing collected packages: blobuploader, requests, docopt 17:40:52 INFO - Running setup.py install for blobuploader 17:40:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:40:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:40:52 INFO - Running setup.py install for requests 17:40:53 INFO - Running setup.py install for docopt 17:40:53 INFO - Successfully installed blobuploader requests docopt 17:40:53 INFO - Cleaning up... 17:40:53 INFO - Return code: 0 17:40:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:40: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')]} 17:40:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:40: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')]} 17:40:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:40:53 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 0xdd81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1146f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1144130>, '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 0x1145030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11454c0>, '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': '232498196343f89f466a4a9a000001c8-1503708009.729582-841113133', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:40:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:40:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:40:53 INFO - Using env: {'DISPLAY': ':0', 17:40:53 INFO - 'HOME': '/home/cltbld', 17:40:53 INFO - 'LANG': 'en_US.UTF-8', 17:40:53 INFO - 'LANGUAGE': 'en_US:en', 17:40:53 INFO - 'LOGNAME': 'cltbld', 17:40:53 INFO - 'MAIL': '/var/mail/cltbld', 17:40:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:40:53 INFO - 'MOZ_NO_REMOTE': '1', 17:40:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:40:53 INFO - 'NO_EM_RESTART': '1', 17:40:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:40:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:40:53 INFO - 'PWD': '/builds/slave/test', 17:40:53 INFO - 'SHELL': '/bin/bash', 17:40:53 INFO - 'SHLVL': '1', 17:40:53 INFO - 'TERM': 'linux', 17:40:53 INFO - 'TMOUT': '86400', 17:40:53 INFO - 'USER': 'cltbld', 17:40:53 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1503708009.729582-841113133', 17:40:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:40:53 INFO - '_': '/tools/buildbot/bin/python'} 17:40:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:40:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:40:53 INFO - Running setup.py (path:/tmp/pip-eWCsxO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:40:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:40:53 INFO - Running setup.py (path:/tmp/pip-1K7Zwn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:40:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:40:53 INFO - Running setup.py (path:/tmp/pip-yEPldh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:40:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:40:53 INFO - Running setup.py (path:/tmp/pip-xlgkRe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:40:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:40:53 INFO - Running setup.py (path:/tmp/pip-BoAIp8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:40:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:40:53 INFO - Running setup.py (path:/tmp/pip-xyA7Ue-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:40:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:40:53 INFO - Running setup.py (path:/tmp/pip-m2FJ68-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:40:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:40:53 INFO - Running setup.py (path:/tmp/pip-x8RhZk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:40:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:40:54 INFO - Running setup.py (path:/tmp/pip-f0nGVn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:40:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:40:54 INFO - Running setup.py (path:/tmp/pip-o4yfYX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:40:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:40:54 INFO - Running setup.py (path:/tmp/pip-1QSmNc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:40:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:40:54 INFO - Running setup.py (path:/tmp/pip-Zs4qq_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:40:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:40:54 INFO - Running setup.py (path:/tmp/pip-QmDOTP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:40:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:40:54 INFO - Running setup.py (path:/tmp/pip-77LYfe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:40:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:40:54 INFO - Running setup.py (path:/tmp/pip-8TJsIR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:40:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:40:54 INFO - Running setup.py (path:/tmp/pip-MLpQqC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:40:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:40:54 INFO - Running setup.py (path:/tmp/pip-ZUx4NI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:40:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:40:54 INFO - Running setup.py install for manifestparser 17:40:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:40:54 INFO - Running setup.py install for mozcrash 17:40:54 INFO - Running setup.py install for mozdebug 17:40:54 INFO - Running setup.py install for mozdevice 17:40:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:40:55 INFO - Running setup.py install for mozfile 17:40:55 INFO - Running setup.py install for mozhttpd 17:40:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:40:55 INFO - Running setup.py install for mozinfo 17:40:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:40:55 INFO - Running setup.py install for mozInstall 17:40:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:40:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:40:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:40:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:40:55 INFO - Running setup.py install for mozleak 17:40:55 INFO - Running setup.py install for mozlog 17:40:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:40:55 INFO - Running setup.py install for moznetwork 17:40:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:40:55 INFO - Running setup.py install for mozprocess 17:40:55 INFO - Running setup.py install for mozprofile 17:40:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:40:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:40:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:40:55 INFO - Running setup.py install for mozrunner 17:40:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:40:56 INFO - Running setup.py install for mozscreenshot 17:40:56 INFO - Running setup.py install for moztest 17:40:56 INFO - Running setup.py install for mozversion 17:40:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:40:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:40:56 INFO - Cleaning up... 17:40:56 INFO - Return code: 0 17:40:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:40:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:40:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:40:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:40:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:40:56 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 0xdd81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1146f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1144130>, '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 0x1145030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11454c0>, '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': '232498196343f89f466a4a9a000001c8-1503708009.729582-841113133', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:40:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:40:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:40:56 INFO - Using env: {'DISPLAY': ':0', 17:40:56 INFO - 'HOME': '/home/cltbld', 17:40:56 INFO - 'LANG': 'en_US.UTF-8', 17:40:56 INFO - 'LANGUAGE': 'en_US:en', 17:40:56 INFO - 'LOGNAME': 'cltbld', 17:40:56 INFO - 'MAIL': '/var/mail/cltbld', 17:40:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:40:56 INFO - 'MOZ_NO_REMOTE': '1', 17:40:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:40:56 INFO - 'NO_EM_RESTART': '1', 17:40:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:40:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:40:56 INFO - 'PWD': '/builds/slave/test', 17:40:56 INFO - 'SHELL': '/bin/bash', 17:40:56 INFO - 'SHLVL': '1', 17:40:56 INFO - 'TERM': 'linux', 17:40:56 INFO - 'TMOUT': '86400', 17:40:56 INFO - 'USER': 'cltbld', 17:40:56 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1503708009.729582-841113133', 17:40:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:40:56 INFO - '_': '/tools/buildbot/bin/python'} 17:40:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:40:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:40:56 INFO - Running setup.py (path:/tmp/pip-IFU79C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:40:56 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 17:40:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:40:56 INFO - Running setup.py (path:/tmp/pip-wUvjeI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:40:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:40:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:40:56 INFO - Running setup.py (path:/tmp/pip-7c2sIw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:40:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:40:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:40:56 INFO - Running setup.py (path:/tmp/pip-IDl56x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:40:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:40:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:40:56 INFO - Running setup.py (path:/tmp/pip-_2Yng1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:40:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 17:40:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:40:56 INFO - Running setup.py (path:/tmp/pip-9egW_s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:40:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 17:40:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:40:57 INFO - Running setup.py (path:/tmp/pip-3whIFO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:40:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 17:40:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:40:57 INFO - Running setup.py (path:/tmp/pip-7xhTgU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:40:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:40:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:40:57 INFO - Running setup.py (path:/tmp/pip-6_Z4rU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:40:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 17:40:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:40:57 INFO - Running setup.py (path:/tmp/pip-ggjtOG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:40:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:40:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:40:57 INFO - Running setup.py (path:/tmp/pip-T0MDAZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:40:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 17:40:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:40:57 INFO - Running setup.py (path:/tmp/pip-jDcYqV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:40:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:40:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:40:57 INFO - Running setup.py (path:/tmp/pip-LyCxrv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:40:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 17:40:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:40:57 INFO - Running setup.py (path:/tmp/pip-Z3XNM7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:40:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 17:40:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:40:57 INFO - Running setup.py (path:/tmp/pip-xY6s2r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:40:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 17:40:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:40:57 INFO - Running setup.py (path:/tmp/pip-DmrE_B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:40:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:40:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:40:57 INFO - Running setup.py (path:/tmp/pip-b7EFch-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:40:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 17:40:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:40:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:40:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:40:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:40:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:40:57 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:40:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:40:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:40:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:40:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:40:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:40:58 INFO - Downloading blessings-1.6.tar.gz 17:40:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:40:59 INFO - Installing collected packages: blessings 17:40:59 INFO - Running setup.py install for blessings 17:40:59 INFO - Successfully installed blessings 17:40:59 INFO - Cleaning up... 17:40:59 INFO - Return code: 0 17:40:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:40:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:40:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:40:59 INFO - Reading from file tmpfile_stdout 17:40:59 INFO - Current package versions: 17:40:59 INFO - argparse == 1.2.1 17:40:59 INFO - blessings == 1.6 17:40:59 INFO - blobuploader == 1.2.4 17:40:59 INFO - docopt == 0.6.1 17:40:59 INFO - functools32 == 3.2.3-2 17:40:59 INFO - jsonschema == 2.5.1 17:40:59 INFO - manifestparser == 1.1 17:40:59 INFO - mozInstall == 1.13 17:40:59 INFO - mozcrash == 1.0 17:40:59 INFO - mozdebug == 0.1 17:40:59 INFO - mozdevice == 0.51 17:40:59 INFO - mozfile == 1.2 17:40:59 INFO - mozhttpd == 0.7 17:40:59 INFO - mozinfo == 0.10 17:40:59 INFO - mozleak == 0.1 17:40:59 INFO - mozlog == 3.5 17:40:59 INFO - moznetwork == 0.27 17:40:59 INFO - mozprocess == 0.25 17:40:59 INFO - mozprofile == 0.28 17:40:59 INFO - mozrunner == 6.13 17:40:59 INFO - mozscreenshot == 0.1 17:40:59 INFO - mozsystemmonitor == 0.3 17:40:59 INFO - moztest == 0.8 17:40:59 INFO - mozversion == 1.4 17:40:59 INFO - psutil == 3.1.1 17:40:59 INFO - requests == 1.2.3 17:40:59 INFO - wsgiref == 0.1.2 17:40:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:40:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:40:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:40:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:40:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:40:59 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 0xdd81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1146f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1144130>, '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 0x1145030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11454c0>, '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': '232498196343f89f466a4a9a000001c8-1503708009.729582-841113133', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:40:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 17:40:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:40:59 INFO - Using env: {'DISPLAY': ':0', 17:40:59 INFO - 'HOME': '/home/cltbld', 17:40:59 INFO - 'LANG': 'en_US.UTF-8', 17:40:59 INFO - 'LANGUAGE': 'en_US:en', 17:40:59 INFO - 'LOGNAME': 'cltbld', 17:40:59 INFO - 'MAIL': '/var/mail/cltbld', 17:40:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:40:59 INFO - 'MOZ_NO_REMOTE': '1', 17:40:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:40:59 INFO - 'NO_EM_RESTART': '1', 17:40:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:40:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:40:59 INFO - 'PWD': '/builds/slave/test', 17:40:59 INFO - 'SHELL': '/bin/bash', 17:40:59 INFO - 'SHLVL': '1', 17:40:59 INFO - 'TERM': 'linux', 17:40:59 INFO - 'TMOUT': '86400', 17:40:59 INFO - 'USER': 'cltbld', 17:40:59 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1503708009.729582-841113133', 17:40:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:40:59 INFO - '_': '/tools/buildbot/bin/python'} 17:40:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:40:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:40:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 17:40:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 17:40:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:40:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 17:40:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 17:40:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 17:40:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 17:40:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 17:40:59 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 17:40:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:40:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:40:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:40:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:41:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 17:41:00 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:41:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:41:00 INFO - Installing collected packages: simplejson 17:41:00 INFO - Running setup.py install for simplejson 17:41:00 INFO - building 'simplejson._speedups' extension 17:41:00 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 17:41:01 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 17:41:01 INFO - Successfully installed simplejson 17:41:01 INFO - Cleaning up... 17:41:01 INFO - Return code: 0 17:41:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:41:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:41:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:41:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:41:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:41:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdd81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1146f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1144130>, '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 0x1145030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11454c0>, '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': '232498196343f89f466a4a9a000001c8-1503708009.729582-841113133', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:41:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:41:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:41:01 INFO - Using env: {'DISPLAY': ':0', 17:41:01 INFO - 'HOME': '/home/cltbld', 17:41:01 INFO - 'LANG': 'en_US.UTF-8', 17:41:01 INFO - 'LANGUAGE': 'en_US:en', 17:41:01 INFO - 'LOGNAME': 'cltbld', 17:41:01 INFO - 'MAIL': '/var/mail/cltbld', 17:41:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:41:01 INFO - 'MOZ_NO_REMOTE': '1', 17:41:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:41:01 INFO - 'NO_EM_RESTART': '1', 17:41:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:41:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:41:01 INFO - 'PWD': '/builds/slave/test', 17:41:01 INFO - 'SHELL': '/bin/bash', 17:41:01 INFO - 'SHLVL': '1', 17:41:01 INFO - 'TERM': 'linux', 17:41:01 INFO - 'TMOUT': '86400', 17:41:01 INFO - 'USER': 'cltbld', 17:41:01 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1503708009.729582-841113133', 17:41:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:41:01 INFO - '_': '/tools/buildbot/bin/python'} 17:41:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:41:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:41:02 INFO - Cleaning up... 17:41:02 INFO - Return code: 0 17:41:02 INFO - Running post-action listener: _resource_record_post_action 17:41:02 INFO - Running post-action listener: _start_resource_monitoring 17:41:02 INFO - Starting resource monitoring. 17:41:02 INFO - [mozharness: 2017-08-26 00:41:02.074031Z] Finished create-virtualenv step (success) 17:41:02 INFO - [mozharness: 2017-08-26 00:41:02.074586Z] Running install step. 17:41:02 INFO - Running pre-action listener: _resource_record_pre_action 17:41:02 INFO - Running main action method: install 17:41:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:41:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:41:02 INFO - Reading from file tmpfile_stdout 17:41:02 INFO - Detecting whether we're running mozinstall >=1.0... 17:41:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:41:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:41:02 INFO - Reading from file tmpfile_stdout 17:41:02 INFO - Output received: 17:41:02 INFO - Usage: mozinstall [options] installer 17:41:02 INFO - Options: 17:41:02 INFO - -h, --help show this help message and exit 17:41:02 INFO - -d DEST, --destination=DEST 17:41:02 INFO - Directory to install application into. [default: 17:41:02 INFO - "/builds/slave/test"] 17:41:02 INFO - --app=APP Application being installed. [default: firefox] 17:41:02 INFO - mkdir: /builds/slave/test/build/application 17:41:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:41:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 17:41:20 INFO - Reading from file tmpfile_stdout 17:41:20 INFO - Output received: 17:41:20 INFO - /builds/slave/test/build/application/firefox/firefox 17:41:20 INFO - Running post-action listener: _resource_record_post_action 17:41:20 INFO - [mozharness: 2017-08-26 00:41:20.017713Z] Finished install step (success) 17:41:20 INFO - [mozharness: 2017-08-26 00:41:20.017994Z] Running setup-mitmproxy step. 17:41:20 INFO - Running pre-action listener: _resource_record_pre_action 17:41:20 INFO - Running main action method: setup_mitmproxy 17:41:20 INFO - Skipping: mitmproxy is not required 17:41:20 INFO - Running post-action listener: _resource_record_post_action 17:41:20 INFO - [mozharness: 2017-08-26 00:41:20.019152Z] Finished setup-mitmproxy step (success) 17:41:20 INFO - [mozharness: 2017-08-26 00:41:20.019369Z] Running run-tests step. 17:41:20 INFO - Running pre-action listener: _resource_record_pre_action 17:41:20 INFO - Running pre-action listener: _set_gcov_prefix 17:41:20 INFO - Running main action method: run_tests 17:41:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:41:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:41:20 INFO - Python 2.7.3 17:41:20 INFO - Return code: 0 17:41:20 INFO - grabbing minidump binary from tooltool 17:41:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:41:20 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 0x1144130>, '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 0x1145030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11454c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:41:20 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 17:41:20 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 17:41:20 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 17:41:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:41:20 INFO - Return code: 0 17:41:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:41:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:41:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:41:20 INFO - ENV: RUST_BACKTRACE is now full 17:41:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:41:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:41:20 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/WU6AbHM2QRaABo2Jy31ApA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 17:41:20 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/WU6AbHM2QRaABo2Jy31ApA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-025 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 17:41:20 INFO - Using env: {'DISPLAY': ':0', 17:41:20 INFO - 'HOME': '/home/cltbld', 17:41:20 INFO - 'LANG': 'en_US.UTF-8', 17:41:20 INFO - 'LANGUAGE': 'en_US:en', 17:41:20 INFO - 'LOGNAME': 'cltbld', 17:41:20 INFO - 'MAIL': '/var/mail/cltbld', 17:41:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:41:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:41:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:41:20 INFO - 'MOZ_NO_REMOTE': '1', 17:41:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:41:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:41:20 INFO - 'NO_EM_RESTART': '1', 17:41:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:41:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:41:20 INFO - 'PWD': '/builds/slave/test', 17:41:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:41:20 INFO - 'RUST_BACKTRACE': 'full', 17:41:20 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:41:20 INFO - 'SHELL': '/bin/bash', 17:41:20 INFO - 'SHLVL': '1', 17:41:20 INFO - 'TERM': 'linux', 17:41:20 INFO - 'TMOUT': '86400', 17:41:20 INFO - 'USER': 'cltbld', 17:41:20 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1503708009.729582-841113133', 17:41:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:41:20 INFO - '_': '/tools/buildbot/bin/python'} 17:41:20 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/WU6AbHM2QRaABo2Jy31ApA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 17:41:20 INFO - mozversion application_buildid: 20170825232216 17:41:20 INFO - mozversion application_changeset: 86a3c73984a23b1d524eadbd4a62b9b3fa27e46a 17:41:20 INFO - mozversion application_display_name: Nightly 17:41:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:41:20 INFO - mozversion application_name: Firefox 17:41:20 INFO - mozversion application_remotingname: firefox 17:41:20 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:41:20 INFO - mozversion application_vendor: Mozilla 17:41:20 INFO - mozversion application_version: 57.0a1 17:41:20 INFO - mozversion platform_buildid: 20170825232216 17:41:20 INFO - mozversion platform_changeset: 86a3c73984a23b1d524eadbd4a62b9b3fa27e46a 17:41:20 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:41:20 INFO - mozversion platform_version: 57.0a1 17:41:20 INFO - using testdate: 1503708080 17:41:20 INFO - actual date: 1503708080 17:41:20 INFO - starting webserver on 'localhost:33535' 17:41:20 INFO - SUITE-START | Running 2 tests 17:41:20 INFO - TEST-START | dromaeo_css 17:41:20 INFO - Initialising browser for dromaeo_css test... 17:41:20 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:33535/getInfo.html -profile /tmp/tmpz4my3y/profile 17:41:20 INFO - TEST-INFO | started process 29190 (/builds/slave/test/build/application/firefox/firefox http://localhost:33535/getInfo.html) 17:41:26 INFO - TEST-INFO | 29190: exit 0 17:41:26 INFO - Browser initialized. 17:41:26 INFO - Running cycle 1/1 for dromaeo_css test... 17:41:26 INFO - Using env: {'DISPLAY': ':0', 17:41:26 INFO - 'HOME': '/home/cltbld', 17:41:26 INFO - 'JSGC_DISABLE_POISONING': '1', 17:41:26 INFO - 'LANG': 'en_US.UTF-8', 17:41:26 INFO - 'LANGUAGE': 'en_US:en', 17:41:26 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 17:41:26 INFO - 'LOGNAME': 'cltbld', 17:41:26 INFO - 'MAIL': '/var/mail/cltbld', 17:41:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:41:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:41:26 INFO - 'MOZ_CRASHREPORTER': '1', 17:41:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:41:26 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 17:41:26 INFO - 'MOZ_NO_REMOTE': '1', 17:41:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:41:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:41:26 INFO - 'NO_EM_RESTART': '1', 17:41:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:41:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:41:26 INFO - 'PWD': '/builds/slave/test', 17:41:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:41:26 INFO - 'RUST_BACKTRACE': 'full', 17:41:26 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:41:26 INFO - 'SHELL': '/bin/bash', 17:41:26 INFO - 'SHLVL': '1', 17:41:26 INFO - 'TERM': 'linux', 17:41:26 INFO - 'TMOUT': '86400', 17:41:26 INFO - 'USER': 'cltbld', 17:41:26 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1503708009.729582-841113133', 17:41:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:41:26 INFO - '_': '/tools/buildbot/bin/python'} 17:41:26 INFO - TEST-INFO | started process 29365 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpz4my3y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:41:27 INFO - PID 29365 | 17:41:27 INFO - PID 29365 | (/builds/slave/test/build/application/firefox/firefox:29416): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:41:27 INFO - PID 29365 | 17:41:27 INFO - PID 29365 | 17:41:27 INFO - PID 29365 | (/builds/slave/test/build/application/firefox/firefox:29472): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:41:27 INFO - PID 29365 | 17:41:27 INFO - PID 29365 | __metrics Screen width/height:1600/1200 17:41:27 INFO - PID 29365 | colorDepth:24 17:41:27 INFO - PID 29365 | Browser inner width/height: 1024/768 17:41:27 INFO - PID 29365 | __metrics 17:41:37 INFO - PID 29365 | RSS: Main: 166383616 17:41:37 INFO - PID 29365 | 17:44:34 INFO - PID 29365 | Cycle 1(1): loaded http://localhost:33535/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33535/tests/dromaeo/cssquery-ext.html) 17:44:36 INFO - PID 29365 | RSS: Main: 170229760 17:44:36 INFO - PID 29365 | 17:47:37 INFO - PID 29365 | Cycle 1(1): loaded http://localhost:33535/tests/dromaeo/cssquery-ext.html (next: http://localhost:33535/tests/dromaeo/cssquery-jquery.html) 17:47:38 INFO - PID 29365 | RSS: Main: 166400000 17:47:38 INFO - PID 29365 | 17:50:39 INFO - PID 29365 | Cycle 1(1): loaded http://localhost:33535/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33535/tests/dromaeo/cssquery-mootools.html) 17:50:40 INFO - PID 29365 | RSS: Main: 169390080 17:50:40 INFO - PID 29365 | 17:53:41 INFO - PID 29365 | Cycle 1(1): loaded http://localhost:33535/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33535/tests/dromaeo/cssquery-prototype.html) 17:53:42 INFO - PID 29365 | RSS: Main: 167247872 17:53:42 INFO - PID 29365 | 17:56:45 INFO - PID 29365 | Cycle 1(1): loaded http://localhost:33535/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33535/tests/dromaeo/cssquery-yui.html) 17:56:46 INFO - PID 29365 | RSS: Main: 171433984 17:56:46 INFO - PID 29365 | 17:59:47 INFO - PID 29365 | Cycle 1(1): loaded http://localhost:33535/tests/dromaeo/cssquery-yui.html (next: http://localhost:33535/tests/dromaeo/cssquery-dojo.html) 17:59:48 INFO - PID 29365 | RSS: Main: 171208704 17:59:48 INFO - PID 29365 | 17:59:48 INFO - PID 29365 | __start_tp_report 17:59:48 INFO - PID 29365 | _x_x_mozilla_page_load 17:59:48 INFO - PID 29365 | _x_x_mozilla_page_load_details 17:59:48 INFO - PID 29365 | |i|pagename|runs| 17:59:48 INFO - PID 29365 | |0;dojo.html;3767.566729826071;3824.7322687411893;3864.207837393334;3872.4772155758974;3882.4176373543964;6092.299385570655;6095.359987201341;6135.447809697126;6167.167432396625;6182.505399568035;6069.908951365733;6136.110264011716;6145.446909778119;6167.444929956303;6232.657203853786;5499.890002199953;5549.528290095347;5553.750081246354;5566.471185237396;5586.497215250627;310.8969048556272;5465.344158700961;5478.45215478453;5633.464820842034;5635.6618602883755;5473.17902314654;5538.6122971392015;5614.9157762633595;5626.971865140689;5645.463680950324;5525.917111243334;5546.805861794818;5591.440855914417;5607.551395888319;5610.18652295419;5513.669179849222;5523.088690366085;5595.916061259084;5599.4120617335;5602.579806514487;6094.146819445281;6138.600990935575;6149.600275982047;6163.660998645073;6190.164327815777;6506.446952009038;6591.340865913418;6602.306757790411;6602.834929126762;6726.93273067268;6527.347265273482;6632.038354438628;6632.971889357157;6670.3329667033395;6725.428338591177;6193.81418557444;6274.623522588659;6284.7486100555925;6287.182666253403;6289.622622642611;6813.591184528944;6825.112735344473;6828.658567071627;6912.239653638096;6916.6541672916155;6468.773592924225;6554.475641948633;6564.212294524687;6602.1747281589805;6652.401283884474;6705.966470167618;6732.057511948331;6752.864942701119;6778.898316525256;6779.220389655155;6578.407943285128;6600.702968366435;6619.900701489481;6641.369069938348;6700.899486507707;6511.609303441809;6612.933870661232;6687.933120668731;6694.531382803254;6695.966520167465;4955.1823949048;4992.550670439678;5010.824621138243;5026.045051440215;5028.522290382408;4617.8383756568355;4643.257078867365;4671.089137618132;4677.836275730333;4701.670883038223;6153.907691384633;6164.496291826061;6168.845778855564;6242.812715618538;6260.874782504325;6512.185976752906;6621.9006714899315;6643.136392269071;6723.058771771955;6727.899081513781;6130.049842274455;6140.263168419819;6164;6198.535109866778;6237.625742455467;5521.503064724114;5547.694876781735;5585.664860108406;5591.664500130005;5596;6873.140857392826;6947.478939079489;7039.120109986252;7040.5071644984355;7073.540219885691;6497.155369801895;6511.153550038464;6591.143151390289;6605.174353205849;6614.074029635759;6915.308469153045;6958;6992.16094068715;7012;7020.403265722471;6497;6515.609063456208;6600.80197594073;6601.207855057424;6645.368689974444;6625.271220165681;6641.070250165078;6701.463882889455;6737.326267373223;6738.73045078211;6410.903836442364;6480.384363485461;6503.902441463287;6506.4469520091325;6512.185976752906;6391.6258004529245;6395.328490508616;6479.287278399278;6498.740050397932;6503.837404064936;6303.716332765129;6343.111964324906;6346.365363463617;6404.967975160094;6412.871742565029;6435.613863168225;6438.6136831790245;6445.516586255956;6475.838104047437;6508.08886755864;6309.526785491014;6315.179026726496;6398.87202255943;6412.807615771534;6413.0701048348665 17:59:48 INFO - PID 29365 | |1;ext.html;921.4010892919601;941.8398872191731;968.7239136846;995.9103680668738;998.1515711645103;42061.369079463795;42963.35554966678;43012.78493607535;43069.35395969059;43102.353464698055;39006.8049659752;39313;39367;39406.60593394065;39430.60569394305;7101.715931362753;7219.566825990431;7221.855562888739;7225.530340527849;7226.421886249087;7102.112235970504;7176.246494118121;7184.497085204038;7185.173705023937;7185.497015208937;7707.190744971781;7907.327877130422;7908.090569584485;7909.090454597708;7909.24862138096;7806.258405451473;7859.410544209207;7863.52818830872;7866.41001924855;7867.331276841475;7621.275978782007;7683.500572462828;7808.141104478503;7828.060632724053;7835.255650713173;39703.20593588141;40065.39901901474;40091.7995410024;40196.598034019575;40213.19573608541;3421.264428147935;3468.1676397664633;3475.582930048385;3476.7566270361085;3481.425564781808;32192.678073219202;32249.51625725616;32270.031899043068;32292.354152917043;32318.19204519906;5243.423223445456;5267.104592219332;5302.363716354023;5306.389765176977;5314.92027619586;205232;205286;205524.94475055207;205654;206017.96991015098;49162.75418622884;49325.26012109821;49348.50651493511;49401.25898111531;49417;50374;50399.74800125976;50525;50534.24198637023;50730.49269507331;15711.921440392953;15722.68554628901;15787.447439339569;15838.841611583966;15842.52472425829;12801.103922725506;12823.743525129632;12824.615261541981;12834.80747788784;12841.293728844816;14125.223112728692;14182.432702691984;14458.710825783426;14471.638209044859;14564.781528277084;5701.2018317435595;5762.279715035621;5781.4218578141845;5801.564882633819;5829.36777702244;1029.4389557691077;1062.877769056553;1064.180580952662;1064.414571985405;1066.3655125200494;23587;23657.29028129159;23759.287221383387;23836.16573419922;24048.87975560111;1144.181909934401;1145.856767904012;1146.2492067695673;1165.3648761425043;1176.2589568571916;12552.372381380894;12771.680707982376;16811.91594042022;17083.658326833392;17131;270018;270589;270769;271713;271954;60325.69837150786;60505.39494605086;60543.39456605377;60656.393436065955;60784;1495.7008598280388;1499.955091164937;1513.9091654500764;1525.6643538421529;1531.5788158256792;27887.721122788513;28293.858530707214;28530.286742831595;28577.28556786097;28653.70770338326;40166;40562.18875622412;40605;40615.59384406118;40692.389614156404;239857;240173;240229;240404;240471;35441.46837797487;35553.64446355607;35768;35911.10222244465;35947.46078808768;44628.55371446244;44762;45224.547754522035;45294;45397.773011134734;31993.520097198096;32118.197045073124;34348.14129646779;35500.46749298711;35896.46155307725;34205.65794342025;34586;34602.82698586592;34676;35263;40371;40416.79791601023;40672.79663601663;40691.79654101829;40834.1833163341;34265;34364;34399.828000860834;34441.48337774885;35000.47499287462;24482.51034979255;25473.363165921;26115.608265875646;26155.607665884647;26694.332641684112 17:59:48 INFO - PID 29365 | |2;jquery.html;580.7851095094816;589.8053642298042;598.5301538292441;600.6066026752477;610.5817515002224;22691;23526;24188.15341463049;24223.75776242237;24270.514589708197;24238.03047878087;24669.383265418375;24801.503969920635;24809.875950620266;24842.130525431614;6390.71241794118;6518.902216466757;6526.184226971629;6526.934730652681;6529.281779004329;6122.54080943931;6361.332060133689;6370.49036077115;6438.323975982525;6507.772227972022;6325.873482530346;6327.873442531147;6329.651869147195;6330.778422755205;6331.746730130789;6341.2707538633185;6347.619142851444;6348.079528468346;6348.682565871711;6351.26960399553;5920.644761314292;5926;5927.407259274081;5939;5944.851378715523;30104;30385;30712.692873071206;30945.226369340722;30949.845250773826;2146.6887301341376;2249.572581209581;2250.381145185087;2250.6961560189493;2250.932472025842;19211.807881921282;19656;20781.688274675893;20819.791802081938;20839.479013024644;2469.3826543364157;2475.653408522808;2516.4338023944647;2522.990803678525;2537.949241015188;146696;153951.2302438492;154070;154083;154380;15441.382344706086;15604.843951560566;15620.297086631128;16036.198190090448;16048.67902641964;25257.242282731546;25304;25311;25338.493230135664;25384.36539086501;10285.331453455501;10294.124999374988;10306.381617102998;10417.479126043667;10593.735156620993;7769.417293702995;8318.292945099613;8640.30877529796;9336.95331523338;9542.379745316532;9649.324547281763;9895.901040989498;9991.400515969066;10030.949845250872;10041.548130334153;2848.643919510061;2866.498362786504;2884.5961565380862;2893.667228268776;2964.5256758918467;997.9600815967425;1020.8366661334151;1023.2428003277521;1025.4821315235758;1026.1431704526804;20551.691724624143;20609.587808243752;20711;20805.063772129986;21296.25463108784;1078.4984981983416;1083.2092572422018;1087.4019289390803;1087.6465148826662;1087.9020888120108;10742.624008159833;11255.94372028151;11414.086873050303;11564.537418503165;13083.476660933646;672751;678831;680243;681323;685543;132625.336873315;135778;137094;137487;143152;1248.862625111237;1275.4961790092862;1306.764782339188;1310.3775706539318;1316.5655333739842;21299.78700212978;21314.147434102462;21416.78583214148;21423.250186243407;21431.357059288246;62850;63140.68429657822;63193.36806631875;63469.682651586445;64577.67711161414;79539.60230199044;79877.20122798698;80297.59851200707;80333.59833200797;80867.19132808596;12708.3010434427;13259.867401325862;14660.56018319452;15135.545933622008;15213.391464341303;23966.041358345472;24349.634755479037;24436.389090272885;24451.633225501988;24554.140605078737;17647;17850.91074544619;18007.00961447133;18031.819681803016;18040.909795450938;16008.919955400148;16053.759193611872;16492.752608710638;16518.339266429208;17296.048717320667;18200.635987280446;19197.040147992266;19406.320778772675;19460;19573.804261957768;14684.77972830387;15417.383304667688;15476;15479.84520154829;15648.530544083696;19342.129604167563;19557.11992960292;19660.90169549143;19714.309999149962;19829.30597429083 17:59:48 INFO - PID 29365 | |3;mootools.html;1421.331973972233;1457.1694134343415;1459.6642772162402;1478.2017710436357;1504.240358618897;15770.211489425526;16355.427560035401;16443.75334369984;16477.093759843203;16484.093374864377;16643.916780416082;16907;16920.915395423035;16931.661366772656;16938.83061169388;2809.269589906624;2848.9002884899032;2851.8574071296457;2852.0160544612077;2853.6004959305715;2679.075718876994;2752.229375774786;2758.0760445250867;2758.475889580983;2758.600002999564;2645.9603105953424;2684.060578797415;2684.6644169478814;2695.865206739665;2702.3514356554383;2670.1055146525937;2672.2784848091005;2675.103840213531;2687.193841847448;2690.3946612012337;2563.6410902473667;2582.5738753105716;2590.8056895732893;2595.2733234694315;2599.298189488846;15676.764848527282;15912.283947222402;15918.60203494922;15931.601709957344;15990.520284391487;7718.575478348688;8062.193780621949;8063;8063.758087257392;8063.879041814377;5205.453427390145;5441.129419292894;5526.778928842841;5529.917051244234;5569.972150139264;2025.7163997040427;2057.1565658080117;2083.9270625528034;2113.630114729916;2118.5127420693325;26506.867465662548;26663.20010399691;26797.06210282631;26815.865920670272;26843.19470415891;6617.404433600903;6725.932740672629;6758.695858686371;6826.965865170642;6892.689828957709;17668.11659417024;17695.46913592594;17704.645907081787;17718.734218986727;17728.82271177272;7615.695372185161;7777.922220777833;7780.1052878919645;7781.105172905075;7800.985871836739;5914.172015917775;6039.516838652898;6427.357264273535;7296.927030729731;7303.233160518175;5568.16477528374;5689.544836413077;5704.172894930211;5730.054541000688;5764.798232061858;1651.6614094110919;1666.3334666133644;1669.3990163541116;1687.2829047654698;1692.035539742335;941.5668792355456;970.1365784451843;980.8136454073704;985.0395864032654;1010.5503051142172;9056.592453339616;9210.815783684422;9351.205147562398;9409.435433873852;9496.240300775922;1032.4476405123373;1056.3556230699267;1063.2344711807486;1070.3417398300146;1080.778440419712;5802.65184088956;5825;5917.230760001173;6065.5450841187085;6294.213223347082;23377.649335259986;23447.41381465477;24403.26790196297;24592.385190370383;24604.876975615367;23192.884035579715;23197.188098416475;23339.76660233376;23339.766602334097;23439.179628712915;12344.938275308567;12549.686257843627;12696.365181740875;12781;12797.744045119045;9236;9742.415455072718;9771.267154963549;9919.355241909252;10154.136898363722;19870.205191792167;20054.899725501862;20180.091895865015;20540.281090161774;20570.280040198522;20085;20211.494712631713;20292.79707202909;20510.692339615216;20664.79335206629;12954;13314.93342533281;13422.932885335511;13424.93287533556;13427.19436833793;14935.701285974003;15089.24553772285;15090.924545377204;15094.622634434227;15097.47158849435;12027.15809893299;12064.336461494702;12326.322052286852;12406.62780116598;12451.626451206479;11981.041516678819;12220;12240.449179786752;12350.320732359807;12563.18339307942;10478.842817357898;10494.265401421828;10499.94750026245;10517.9474102629;10536.104431123134;8212.384071194565;8359.122292159236;8422.24199822019;8422.873656895028;8463.703770368007;8226.05400378964;8239.340852731886;8318.251357377865;8331.833363332578;8335.416520843482 17:59:48 INFO - PID 29365 | |4;prototype.html;544.7358031354794;552.2075821196582;553.4437889920629;565.8557067947672;575.8848230353927;6165.260168779747;6203.914314994875;6215.508278013278;6224.564280500367;6254.655993920344;6095.238095238095;6118.174046503721;6126.540509461786;6148.292946311176;6168.845778855531;5070.29015937769;5071.949280507203;5085.618578606619;5114.386273647167;5114.846554603349;4825.686330388531;5041.369828771385;5092.872678183056;5093.2105523643895;5125.718085505296;4891.657583969123;4906.484819093997;4919;4931.630127740415;4937.827176048839;4933.925991110101;4938.827141050064;4945.897993352846;4950.6782059166035;4969.577585905166;4397.956020439787;4457.420535330419;4475.216837053503;4477.3731677565165;4501.177023305567;6039.305479869783;6063.302720187191;6069.15031895535;6109.725062372159;6125.632462052291;5726.484616384545;5759.539236861041;5760.8847823043725;5778.797742079049;5783.224052454803;6572.8356791080605;6580.638064906429;6583;6591.637459939701;6598.802035938881;4920.532549407836;4923.138450771136;4933.605311575066;4937.259411088329;4939.6789208701675;6540.70566824494;6655.966720166368;6719.899201511981;6805.591664500146;6865;5061.493850614983;5067.670601410897;5080.552042667822;5088.211327244283;5090.821821236239;5166.121759300928;5166.147585648326;5166.579190722507;5172.482751724872;5179.92230116541;5634.971825140848;5689.800856969986;5694.9179655865255;5701.059325211377;5733.082706766897;6566.540342176002;6596.868062638816;6604.306547812506;6604.537682362285;6633.900491492632;1766.2052076565597;1774.8668849836056;1776.1563257452865;1787.8390944814769;1790.4091649755549;1201.141184053406;1234.8456442944632;1249.5876360800914;1256.4534427524056;1263.7093468502112;5936.584439089309;5956.970215148896;5998.070299103646;6081.726322315506;6148.231471066117;6538.8365290868105;6586.748517781606;6631.33686631333;6661;6666.899996500057;5993;6001.2498437695285;6005.189299444606;6075.3924607539775;6094;3413.9246137466616;3441.328940856559;3445;3463.2337507871166;3492.511048453219;6701.135492170319;6775.593464392054;6787.219469760942;6882.724691012403;6946.756863509854;6669.46644268467;6702.430293425016;6809.1488563928515;6813.659317034128;6828.965855170792;6888.448924086061;6912.688928998106;6961.547499412522;6999.965000174967;7018.929810701828;6521.445677117498;6546.607203567801;6563.278039415565;6572.155289155706;6620.3710647488415;6511.218653761579;6549.934500654933;6567.274581049002;6621.867562648624;6644.60132392058;6958.338957799001;6985.44116470671;7007.264237255014;7014.158301003912;7026.9648651756415;5050.570701490267;5053.317802096817;5055.823046193365;5092.516210959953;5097.541221290102;6479.287278399466;6554.542910820497;6577.276499585138;6670.332966703485;6707.65232168737;6178.227721534809;6339.746410143727;6411.358864113738;6417.39034791694;6430.488835123836;6277.529185311028;6296.150019747459;6309.684515774285;6421.5825971311715;6455.741770329134;6263.4362907338555;6317.273513546001;6334.524910631813;6384.361563843764;6444.9355506444335;6470.2853743757005;6472.870542589216;6496.220453545605;6496.642684652389;6523.11937888379;6229.065640153832;6262.812115636538;6275.278342990615;6316.494680425463;6335.936640633535 17:59:48 INFO - PID 29365 | |5;yui.html;933.5845548730813;951.8143961927425;976.858355538447;982.1259079419314;989.9604015839367;16861;17963.28146874125;18002.819971800294;18129;18545.165467553958;21218.257360992367;21856;21876.45308867279;21885.12459501618;21893;1061.6814955513335;1097.6652121103061;1099.1042300525046;1099.1316859680842;1100.8954149355798;1011.7774089700291;1068.4817863336275;1081.4646749858791;1095.8301463273206;1098.1544210957559;1125.4991528769701;1141.520561364225;1141.697450175704;1141.78306121837;1142.3774043146504;1130.7060164357285;1136.023020202625;1140.3044143072677;1140.5779861451317;1142.0406858239119;831.9001719793603;836.6946064686346;836.9288610468118;837.2883049408015;837.8240569480416;19987;19996.90001549983;20311.89844050785;20420.795792042038;21268.25561105354;21898.671519927215;21952.89023554888;22057.22799702003;22117.66823497649;22549.887250563806;16995.150242487827;17238.138093095422;17482.125893705263;17772.822271777248;17879.553011174696;3902.453656488094;3935.0162459385156;3940.5271367435803;3941.487606611151;3941.507311586052;143682.28158859242;143814;143979;144420.2778986109;144422;16840.157992100347;17132.657346852993;17494;17574.38489652856;17574.736378954327;32977;33016.83491582527;33613;33615.49576756351;33817.15457113592;7931.325837303893;7948.920510794934;8100.513969161869;8114.918850811417;8134.918650813534;4028.617281358266;4095.4266402703647;4122.896927576775;4125.133721918431;4126.834926602963;5268.578513718893;5339.599530035185;5386.811461598825;5439.129739241703;5444.992676354807;1026.2610920137488;1042.8800687920834;1050.9737256568494;1071.924965252425;1073.7637719701654;723.4754802767951;736.3556887723242;746.06369006896;756.3042001358763;762.7025460070577;12342.01263898886;13106.475740970445;13395.196288222738;13602.727945441036;13996.650083747987;728.5737843361587;740.637087826961;741.1513816679872;760.1524300405008;761.5316580303074;6008.068749343859;6071.9981203101;6088.238970128734;6138.1099740537375;6197.163382943335;126258;127035;128325;131424;131580;110197.44901275443;111327.44336278428;111881.44059279651;114107.42946285216;116353;100656;101349;102030.48984755177;102922;103093;10912.345259284468;11084.889151108386;11089.233598528881;11256.21206515536;11414.885851141715;50031.74984125056;50818.491815081376;51500.48499514957;52921;53705;80075;80695;81372.59313703631;83263.58368208363;83760;20661.380158595268;21165;21255.468613284793;21307.46731331729;21310.254141104986;21426.357209283746;23126.537469250856;23154.652680209474;23184.884075579514;23891.761082388955;21130.26044088511;21189.788102118782;21335.67996480023;21666.458338541663;21769;20779.584408311446;21441.035153417823;21450.24924127648;21467.926603669443;21668.24161154352;19848.801511984697;20798.37604871856;20888;21125.78874211238;21202.893985529972;14253;14858.257087145383;15254.1610211435;15593.220338983232;15652.686946260783;15407.152606606744;15690.686186276438;15844.44544440939;15891.205439727735;16321.918390407973 17:59:48 INFO - PID 29365 | __end_tp_report 17:59:48 INFO - PID 29365 | __start_cc_report 17:59:48 INFO - PID 29365 | _x_x_mozilla_cycle_collect,328 17:59:48 INFO - PID 29365 | __end_cc_report 17:59:48 INFO - PID 29365 | __startTimestamp1503709188194__endTimestamp 17:59:48 INFO - PID 29365 | 17:59:48 INFO - PID 29365 | ------- Summary: start ------- 17:59:48 INFO - PID 29365 | Number of tests: 6 17:59:48 INFO - PID 29365 | 17:59:48 INFO - PID 29365 | [#0] dojo.html Cycles:165 Average:6126.94 Median:6398.87 stddev:825.68 (12.9%) stddev-sans-first:807.20 17:59:48 INFO - PID 29365 | Values: 3767.6 3824.7 3864.2 3872.5 3882.4 6092.3 6095.4 6135.4 6167.2 6182.5 6069.9 6136.1 6145.4 6167.4 6232.7 5499.9 5549.5 5553.8 5566.5 5586.5 310.9 5465.3 5478.5 5633.5 5635.7 5473.2 5538.6 5614.9 5627.0 5645.5 5525.9 5546.8 5591.4 5607.6 5610.2 5513.7 5523.1 5595.9 5599.4 5602.6 6094.1 6138.6 6149.6 6163.7 6190.2 6506.4 6591.3 6602.3 6602.8 6726.9 6527.3 6632.0 6633.0 6670.3 6725.4 6193.8 6274.6 6284.7 6287.2 6289.6 6813.6 6825.1 6828.7 6912.2 6916.7 6468.8 6554.5 6564.2 6602.2 6652.4 6706.0 6732.1 6752.9 6778.9 6779.2 6578.4 6600.7 6619.9 6641.4 6700.9 6511.6 6612.9 6687.9 6694.5 6696.0 4955.2 4992.6 5010.8 5026.0 5028.5 4617.8 4643.3 4671.1 4677.8 4701.7 6153.9 6164.5 6168.8 6242.8 6260.9 6512.2 6621.9 6643.1 6723.1 6727.9 6130.0 6140.3 6164.0 6198.5 6237.6 5521.5 5547.7 5585.7 5591.7 5596.0 6873.1 6947.5 7039.1 7040.5 7073.5 6497.2 6511.2 6591.1 6605.2 6614.1 6915.3 6958.0 6992.2 7012.0 7020.4 6497.0 6515.6 6600.8 6601.2 6645.4 6625.3 6641.1 6701.5 6737.3 6738.7 6410.9 6480.4 6503.9 6506.4 6512.2 6391.6 6395.3 6479.3 6498.7 6503.8 6303.7 6343.1 6346.4 6405.0 6412.9 6435.6 6438.6 6445.5 6475.8 6508.1 6309.5 6315.2 6398.9 6412.8 6413.1 17:59:48 INFO - PID 29365 | 17:59:48 INFO - PID 29365 | [#1] ext.html Cycles:180 Average:41387.24 Median:35660.82 stddev:62495.55 (175.2%) stddev-sans-first:62597.01 17:59:48 INFO - PID 29365 | Values: 921.4 941.8 968.7 995.9 998.2 42061.4 42963.4 43012.8 43069.4 43102.4 39006.8 39313.0 39367.0 39406.6 39430.6 7101.7 7219.6 7221.9 7225.5 7226.4 7102.1 7176.2 7184.5 7185.2 7185.5 7707.2 7907.3 7908.1 7909.1 7909.2 7806.3 7859.4 7863.5 7866.4 7867.3 7621.3 7683.5 7808.1 7828.1 7835.3 39703.2 40065.4 40091.8 40196.6 40213.2 3421.3 3468.2 3475.6 3476.8 3481.4 32192.7 32249.5 32270.0 32292.4 32318.2 5243.4 5267.1 5302.4 5306.4 5314.9 205232.0 205286.0 205524.9 205654.0 206018.0 49162.8 49325.3 49348.5 49401.3 49417.0 50374.0 50399.7 50525.0 50534.2 50730.5 15711.9 15722.7 15787.4 15838.8 15842.5 12801.1 12823.7 12824.6 12834.8 12841.3 14125.2 14182.4 14458.7 14471.6 14564.8 5701.2 5762.3 5781.4 5801.6 5829.4 1029.4 1062.9 1064.2 1064.4 1066.4 23587.0 23657.3 23759.3 23836.2 24048.9 1144.2 1145.9 1146.2 1165.4 1176.3 12552.4 12771.7 16811.9 17083.7 17131.0 270018.0 270589.0 270769.0 271713.0 271954.0 60325.7 60505.4 60543.4 60656.4 60784.0 1495.7 1500.0 1513.9 1525.7 1531.6 27887.7 28293.9 28530.3 28577.3 28653.7 40166.0 40562.2 40605.0 40615.6 40692.4 239857.0 240173.0 240229.0 240404.0 240471.0 35441.5 35553.6 35768.0 35911.1 35947.5 44628.6 44762.0 45224.5 45294.0 45397.8 31993.5 32118.2 34348.1 35500.5 35896.5 34205.7 34586.0 34602.8 34676.0 35263.0 40371.0 40416.8 40672.8 40691.8 40834.2 34265.0 34364.0 34399.8 34441.5 35000.5 24482.5 25473.4 26115.6 26155.6 26694.3 17:59:48 INFO - PID 29365 | 17:59:48 INFO - PID 29365 | [#2] jquery.html Cycles:180 Average:41849.72 Median:12470.97 stddev:113222.76 (907.9%) stddev-sans-first:113497.98 17:59:48 INFO - PID 29365 | Values: 580.8 589.8 598.5 600.6 610.6 22691.0 23526.0 24188.2 24223.8 24270.5 24238.0 24669.4 24801.5 24809.9 24842.1 6390.7 6518.9 6526.2 6526.9 6529.3 6122.5 6361.3 6370.5 6438.3 6507.8 6325.9 6327.9 6329.7 6330.8 6331.7 6341.3 6347.6 6348.1 6348.7 6351.3 5920.6 5926.0 5927.4 5939.0 5944.9 30104.0 30385.0 30712.7 30945.2 30949.8 2146.7 2249.6 2250.4 2250.7 2250.9 19211.8 19656.0 20781.7 20819.8 20839.5 2469.4 2475.7 2516.4 2523.0 2537.9 146696.0 153951.2 154070.0 154083.0 154380.0 15441.4 15604.8 15620.3 16036.2 16048.7 25257.2 25304.0 25311.0 25338.5 25384.4 10285.3 10294.1 10306.4 10417.5 10593.7 7769.4 8318.3 8640.3 9337.0 9542.4 9649.3 9895.9 9991.4 10030.9 10041.5 2848.6 2866.5 2884.6 2893.7 2964.5 998.0 1020.8 1023.2 1025.5 1026.1 20551.7 20609.6 20711.0 20805.1 21296.3 1078.5 1083.2 1087.4 1087.6 1087.9 10742.6 11255.9 11414.1 11564.5 13083.5 672751.0 678831.0 680243.0 681323.0 685543.0 132625.3 135778.0 137094.0 137487.0 143152.0 1248.9 1275.5 1306.8 1310.4 1316.6 21299.8 21314.1 21416.8 21423.3 21431.4 62850.0 63140.7 63193.4 63469.7 64577.7 79539.6 79877.2 80297.6 80333.6 80867.2 12708.3 13259.9 14660.6 15135.5 15213.4 23966.0 24349.6 24436.4 24451.6 24554.1 17647.0 17850.9 18007.0 18031.8 18040.9 16008.9 16053.8 16492.8 16518.3 17296.0 18200.6 19197.0 19406.3 19460.0 19573.8 14684.8 15417.4 15476.0 15479.8 15648.5 19342.1 19557.1 19660.9 19714.3 19829.3 17:59:48 INFO - PID 29365 | 17:59:48 INFO - PID 29365 | [#3] mootools.html Cycles:180 Average:10007.34 Median:24598.63 stddev:7146.16 (29.1%) stddev-sans-first:7137.09 17:59:48 INFO - PID 29365 | Values: 1421.3 1457.2 1459.7 1478.2 1504.2 15770.2 16355.4 16443.8 16477.1 16484.1 16643.9 16907.0 16920.9 16931.7 16938.8 2809.3 2848.9 2851.9 2852.0 2853.6 2679.1 2752.2 2758.1 2758.5 2758.6 2646.0 2684.1 2684.7 2695.9 2702.4 2670.1 2672.3 2675.1 2687.2 2690.4 2563.6 2582.6 2590.8 2595.3 2599.3 15676.8 15912.3 15918.6 15931.6 15990.5 7718.6 8062.2 8063.0 8063.8 8063.9 5205.5 5441.1 5526.8 5529.9 5570.0 2025.7 2057.2 2083.9 2113.6 2118.5 26506.9 26663.2 26797.1 26815.9 26843.2 6617.4 6725.9 6758.7 6827.0 6892.7 17668.1 17695.5 17704.6 17718.7 17728.8 7615.7 7777.9 7780.1 7781.1 7801.0 5914.2 6039.5 6427.4 7296.9 7303.2 5568.2 5689.5 5704.2 5730.1 5764.8 1651.7 1666.3 1669.4 1687.3 1692.0 941.6 970.1 980.8 985.0 1010.6 9056.6 9210.8 9351.2 9409.4 9496.2 1032.4 1056.4 1063.2 1070.3 1080.8 5802.7 5825.0 5917.2 6065.5 6294.2 23377.6 23447.4 24403.3 24592.4 24604.9 23192.9 23197.2 23339.8 23339.8 23439.2 12344.9 12549.7 12696.4 12781.0 12797.7 9236.0 9742.4 9771.3 9919.4 10154.1 19870.2 20054.9 20180.1 20540.3 20570.3 20085.0 20211.5 20292.8 20510.7 20664.8 12954.0 13314.9 13422.9 13424.9 13427.2 14935.7 15089.2 15090.9 15094.6 15097.5 12027.2 12064.3 12326.3 12406.6 12451.6 11981.0 12220.0 12240.4 12350.3 12563.2 10478.8 10494.3 10499.9 10517.9 10536.1 8212.4 8359.1 8422.2 8422.9 8463.7 8226.1 8239.3 8318.3 8331.8 8335.4 17:59:48 INFO - PID 29365 | 17:59:48 INFO - PID 29365 | [#4] prototype.html Cycles:180 Average:5536.17 Median:6126.09 stddev:1545.91 (25.2%) stddev-sans-first:1504.16 17:59:48 INFO - PID 29365 | Values: 544.7 552.2 553.4 565.9 575.9 6165.3 6203.9 6215.5 6224.6 6254.7 6095.2 6118.2 6126.5 6148.3 6168.8 5070.3 5071.9 5085.6 5114.4 5114.8 4825.7 5041.4 5092.9 5093.2 5125.7 4891.7 4906.5 4919.0 4931.6 4937.8 4933.9 4938.8 4945.9 4950.7 4969.6 4398.0 4457.4 4475.2 4477.4 4501.2 6039.3 6063.3 6069.2 6109.7 6125.6 5726.5 5759.5 5760.9 5778.8 5783.2 6572.8 6580.6 6583.0 6591.6 6598.8 4920.5 4923.1 4933.6 4937.3 4939.7 6540.7 6656.0 6719.9 6805.6 6865.0 5061.5 5067.7 5080.6 5088.2 5090.8 5166.1 5166.1 5166.6 5172.5 5179.9 5635.0 5689.8 5694.9 5701.1 5733.1 6566.5 6596.9 6604.3 6604.5 6633.9 1766.2 1774.9 1776.2 1787.8 1790.4 1201.1 1234.8 1249.6 1256.5 1263.7 5936.6 5957.0 5998.1 6081.7 6148.2 6538.8 6586.7 6631.3 6661.0 6666.9 5993.0 6001.2 6005.2 6075.4 6094.0 3413.9 3441.3 3445.0 3463.2 3492.5 6701.1 6775.6 6787.2 6882.7 6946.8 6669.5 6702.4 6809.1 6813.7 6829.0 6888.4 6912.7 6961.5 7000.0 7018.9 6521.4 6546.6 6563.3 6572.2 6620.4 6511.2 6549.9 6567.3 6621.9 6644.6 6958.3 6985.4 7007.3 7014.2 7027.0 5050.6 5053.3 5055.8 5092.5 5097.5 6479.3 6554.5 6577.3 6670.3 6707.7 6178.2 6339.7 6411.4 6417.4 6430.5 6277.5 6296.2 6309.7 6421.6 6455.7 6263.4 6317.3 6334.5 6384.4 6444.9 6470.3 6472.9 6496.2 6496.6 6523.1 6229.1 6262.8 6275.3 6316.5 6335.9 17:59:48 INFO - PID 29365 | 17:59:48 INFO - PID 29365 | [#5] yui.html Cycles:180 Average:26976.31 Median:21147.63 stddev:37517.61 (177.4%) stddev-sans-first:37571.90 17:59:48 INFO - PID 29365 | Values: 933.6 951.8 976.9 982.1 990.0 16861.0 17963.3 18002.8 18129.0 18545.2 21218.3 21856.0 21876.5 21885.1 21893.0 1061.7 1097.7 1099.1 1099.1 1100.9 1011.8 1068.5 1081.5 1095.8 1098.2 1125.5 1141.5 1141.7 1141.8 1142.4 1130.7 1136.0 1140.3 1140.6 1142.0 831.9 836.7 836.9 837.3 837.8 19987.0 19996.9 20311.9 20420.8 21268.3 21898.7 21952.9 22057.2 22117.7 22549.9 16995.2 17238.1 17482.1 17772.8 17879.6 3902.5 3935.0 3940.5 3941.5 3941.5 143682.3 143814.0 143979.0 144420.3 144422.0 16840.2 17132.7 17494.0 17574.4 17574.7 32977.0 33016.8 33613.0 33615.5 33817.2 7931.3 7948.9 8100.5 8114.9 8134.9 4028.6 4095.4 4122.9 4125.1 4126.8 5268.6 5339.6 5386.8 5439.1 5445.0 1026.3 1042.9 1051.0 1071.9 1073.8 723.5 736.4 746.1 756.3 762.7 12342.0 13106.5 13395.2 13602.7 13996.7 728.6 740.6 741.2 760.2 761.5 6008.1 6072.0 6088.2 6138.1 6197.2 126258.0 127035.0 128325.0 131424.0 131580.0 110197.4 111327.4 111881.4 114107.4 116353.0 100656.0 101349.0 102030.5 102922.0 103093.0 10912.3 11084.9 11089.2 11256.2 11414.9 50031.7 50818.5 51500.5 52921.0 53705.0 80075.0 80695.0 81372.6 83263.6 83760.0 20661.4 21165.0 21255.5 21307.5 21310.3 21426.4 23126.5 23154.7 23184.9 23891.8 21130.3 21189.8 21335.7 21666.5 21769.0 20779.6 21441.0 21450.2 21467.9 21668.2 19848.8 20798.4 20888.0 21125.8 21202.9 14253.0 14858.3 15254.2 15593.2 15652.7 15407.2 15690.7 15844.4 15891.2 16321.9 17:59:48 INFO - PID 29365 | -------- Summary: end -------- 17:59:48 INFO - PID 29365 | 17:59:48 INFO - TEST-INFO | 29365: exit 0 17:59:48 INFO - TEST-OK | dromaeo_css | took 1108546ms 17:59:48 INFO - TEST-START | kraken 17:59:48 INFO - Initialising browser for kraken test... 17:59:48 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:33535/getInfo.html -profile /tmp/tmp_3vxal/profile 17:59:48 INFO - TEST-INFO | started process 29779 (/builds/slave/test/build/application/firefox/firefox http://localhost:33535/getInfo.html) 17:59:54 INFO - TEST-INFO | 29779: exit 0 17:59:54 INFO - Browser initialized. 17:59:54 INFO - Running cycle 1/1 for kraken test... 17:59:54 INFO - Using env: {'DISPLAY': ':0', 17:59:54 INFO - 'HOME': '/home/cltbld', 17:59:54 INFO - 'JSGC_DISABLE_POISONING': '1', 17:59:54 INFO - 'LANG': 'en_US.UTF-8', 17:59:54 INFO - 'LANGUAGE': 'en_US:en', 17:59:54 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 17:59:54 INFO - 'LOGNAME': 'cltbld', 17:59:54 INFO - 'MAIL': '/var/mail/cltbld', 17:59:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:59:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:59:54 INFO - 'MOZ_CRASHREPORTER': '1', 17:59:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:59:54 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 17:59:54 INFO - 'MOZ_NO_REMOTE': '1', 17:59:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:59:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:59:54 INFO - 'NO_EM_RESTART': '1', 17:59:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:59:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:59:54 INFO - 'PWD': '/builds/slave/test', 17:59:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:59:54 INFO - 'RUST_BACKTRACE': 'full', 17:59:54 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:59:54 INFO - 'SHELL': '/bin/bash', 17:59:54 INFO - 'SHLVL': '1', 17:59:54 INFO - 'TERM': 'linux', 17:59:54 INFO - 'TMOUT': '86400', 17:59:54 INFO - 'USER': 'cltbld', 17:59:54 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1503708009.729582-841113133', 17:59:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:59:54 INFO - '_': '/tools/buildbot/bin/python'} 17:59:54 INFO - TEST-INFO | started process 29954 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_3vxal/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:59:55 INFO - PID 29954 | 17:59:55 INFO - PID 29954 | (/builds/slave/test/build/application/firefox/firefox:30004): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:59:55 INFO - PID 29954 | 17:59:56 INFO - PID 29954 | 17:59:56 INFO - PID 29954 | (/builds/slave/test/build/application/firefox/firefox:30062): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:59:56 INFO - PID 29954 | 17:59:56 INFO - PID 29954 | __metrics Screen width/height:1600/1200 17:59:56 INFO - PID 29954 | colorDepth:24 17:59:56 INFO - PID 29954 | Browser inner width/height: 1024/768 17:59:56 INFO - PID 29954 | __metrics 18:00:05 INFO - PID 29954 | RSS: Main: 166137856 18:00:05 INFO - PID 29954 | 18:00:08 INFO - PID 29954 | Cycle 1(1): loaded http://localhost:33535/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33535/tests/kraken/driver.html?testName=audio-beat-detection) 18:00:09 INFO - PID 29954 | RSS: Main: 169992192 18:00:09 INFO - PID 29954 | 18:00:11 INFO - PID 29954 | Cycle 1(1): loaded http://localhost:33535/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33535/tests/kraken/driver.html?testName=audio-dft) 18:00:12 INFO - PID 29954 | RSS: Main: 172650496 18:00:12 INFO - PID 29954 | 18:00:15 INFO - PID 29954 | Cycle 1(1): loaded http://localhost:33535/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33535/tests/kraken/driver.html?testName=audio-fft) 18:00:16 INFO - PID 29954 | RSS: Main: 166027264 18:00:16 INFO - PID 29954 | 18:00:18 INFO - PID 29954 | Cycle 1(1): loaded http://localhost:33535/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33535/tests/kraken/driver.html?testName=audio-oscillator) 18:00:18 INFO - PID 29954 | RSS: Main: 166973440 18:00:18 INFO - PID 29954 | 18:00:20 INFO - PID 29954 | Cycle 1(1): loaded http://localhost:33535/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33535/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:00:21 INFO - PID 29954 | RSS: Main: 167645184 18:00:21 INFO - PID 29954 | 18:00:24 INFO - PID 29954 | Cycle 1(1): loaded http://localhost:33535/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33535/tests/kraken/driver.html?testName=imaging-darkroom) 18:00:25 INFO - PID 29954 | RSS: Main: 167354368 18:00:25 INFO - PID 29954 | 18:00:28 INFO - PID 29954 | Cycle 1(1): loaded http://localhost:33535/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33535/tests/kraken/driver.html?testName=imaging-desaturate) 18:00:29 INFO - PID 29954 | RSS: Main: 168853504 18:00:29 INFO - PID 29954 | 18:00:31 INFO - PID 29954 | Cycle 1(1): loaded http://localhost:33535/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33535/tests/kraken/driver.html?testName=json-parse-financial) 18:00:32 INFO - PID 29954 | RSS: Main: 169295872 18:00:32 INFO - PID 29954 | 18:00:34 INFO - PID 29954 | Cycle 1(1): loaded http://localhost:33535/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33535/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:00:34 INFO - PID 29954 | RSS: Main: 168919040 18:00:34 INFO - PID 29954 | 18:00:36 INFO - PID 29954 | Cycle 1(1): loaded http://localhost:33535/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33535/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:00:37 INFO - PID 29954 | RSS: Main: 168878080 18:00:37 INFO - PID 29954 | 18:00:39 INFO - PID 29954 | Cycle 1(1): loaded http://localhost:33535/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33535/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:00:39 INFO - PID 29954 | RSS: Main: 169009152 18:00:39 INFO - PID 29954 | 18:00:42 INFO - PID 29954 | Cycle 1(1): loaded http://localhost:33535/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33535/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:00:42 INFO - PID 29954 | RSS: Main: 168759296 18:00:42 INFO - PID 29954 | 18:00:45 INFO - PID 29954 | Cycle 1(1): loaded http://localhost:33535/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33535/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:00:46 INFO - PID 29954 | RSS: Main: 169185280 18:00:46 INFO - PID 29954 | 18:00:48 INFO - PID 29954 | Cycle 1(1): loaded http://localhost:33535/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33535/tests/kraken/driver.html?testName=ai-astar) 18:00:48 INFO - PID 29954 | RSS: Main: 170631168 18:00:48 INFO - PID 29954 | 18:00:48 INFO - PID 29954 | __start_tp_report 18:00:48 INFO - PID 29954 | _x_x_mozilla_page_load 18:00:48 INFO - PID 29954 | _x_x_mozilla_page_load_details 18:00:48 INFO - PID 29954 | |i|pagename|runs| 18:00:48 INFO - PID 29954 | |0;ai-astar;98;106;98;105;105;106;108;97;105;107 18:00:48 INFO - PID 29954 | |1;audio-beat-detection;144;123;145;174;116;146;142;114;163;113 18:00:48 INFO - PID 29954 | |2;audio-dft;165;165;161;162;162;162;161;161;168;170 18:00:48 INFO - PID 29954 | |3;audio-fft;74;74;72;181;74;73;72;87;93;75 18:00:48 INFO - PID 29954 | |4;audio-oscillator;79;79;129;78;78;79;132;78;78;122 18:00:48 INFO - PID 29954 | |5;imaging-gaussian-blur;114;113;114;113;114;115;114;114;113;113 18:00:48 INFO - PID 29954 | |6;imaging-darkroom;150;150;151;150;152;149;149;149;150;157 18:00:48 INFO - PID 29954 | |7;imaging-desaturate;95;97;94;94;94;94;94;99;94;93 18:00:48 INFO - PID 29954 | |8;json-parse-financial;46;45;45;46;46;46;47;46;45;48 18:00:48 INFO - PID 29954 | |9;json-stringify-tinderbox;51;51;51;51;51;51;52;51;51;51 18:00:48 INFO - PID 29954 | |10;stanford-crypto-aes;73;73;76;77;77;76;75;74;75;78 18:00:48 INFO - PID 29954 | |11;stanford-crypto-ccm;123;120;114;121;114;117;114;125;123;176 18:00:48 INFO - PID 29954 | |12;stanford-crypto-pbkdf2;167;164;174;176;167;163;169;178;165;160 18:00:48 INFO - PID 29954 | |13;stanford-crypto-sha256-iterative;62;63;61;63;60;60;62;63;65;60 18:00:48 INFO - PID 29954 | __end_tp_report 18:00:48 INFO - PID 29954 | __start_cc_report 18:00:48 INFO - PID 29954 | _x_x_mozilla_cycle_collect,907 18:00:48 INFO - PID 29954 | __end_cc_report 18:00:48 INFO - PID 29954 | __startTimestamp1503709248370__endTimestamp 18:00:48 INFO - PID 29954 | 18:00:48 INFO - PID 29954 | ------- Summary: start ------- 18:00:48 INFO - PID 29954 | Number of tests: 14 18:00:48 INFO - PID 29954 | 18:00:48 INFO - PID 29954 | [#0] ai-astar Cycles:10 Average:103.50 Median:107.50 stddev:4.14 (3.9%) stddev-sans-first:3.89 18:00:48 INFO - PID 29954 | Values: 98.0 106.0 98.0 105.0 105.0 106.0 108.0 97.0 105.0 107.0 18:00:48 INFO - PID 29954 | 18:00:48 INFO - PID 29954 | [#1] audio-beat-detection Cycles:10 Average:138.00 Median:144.50 stddev:21.07 (14.6%) stddev-sans-first:22.24 18:00:48 INFO - PID 29954 | Values: 144.0 123.0 145.0 174.0 116.0 146.0 142.0 114.0 163.0 113.0 18:00:48 INFO - PID 29954 | 18:00:48 INFO - PID 29954 | [#2] audio-dft Cycles:10 Average:163.70 Median:163.50 stddev:3.20 (2.0%) stddev-sans-first:3.36 18:00:48 INFO - PID 29954 | Values: 165.0 165.0 161.0 162.0 162.0 162.0 161.0 161.0 168.0 170.0 18:00:48 INFO - PID 29954 | 18:00:48 INFO - PID 29954 | [#3] audio-fft Cycles:10 Average:87.50 Median:74.00 stddev:33.61 (45.4%) stddev-sans-first:35.29 18:00:48 INFO - PID 29954 | Values: 74.0 74.0 72.0 181.0 74.0 73.0 72.0 87.0 93.0 75.0 18:00:48 INFO - PID 29954 | 18:00:48 INFO - PID 29954 | [#4] audio-oscillator Cycles:10 Average:93.20 Median:78.00 stddev:23.91 (30.7%) stddev-sans-first:24.80 18:00:48 INFO - PID 29954 | Values: 79.0 79.0 129.0 78.0 78.0 79.0 132.0 78.0 78.0 122.0 18:00:48 INFO - PID 29954 | 18:00:48 INFO - PID 29954 | [#5] imaging-gaussian-blur Cycles:10 Average:113.70 Median:114.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 18:00:48 INFO - PID 29954 | Values: 114.0 113.0 114.0 113.0 114.0 115.0 114.0 114.0 113.0 113.0 18:00:48 INFO - PID 29954 | 18:00:48 INFO - PID 29954 | [#6] imaging-darkroom Cycles:10 Average:150.70 Median:150.00 stddev:2.41 (1.6%) stddev-sans-first:2.54 18:00:48 INFO - PID 29954 | Values: 150.0 150.0 151.0 150.0 152.0 149.0 149.0 149.0 150.0 157.0 18:00:48 INFO - PID 29954 | 18:00:48 INFO - PID 29954 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:94.00 stddev:1.81 (1.9%) stddev-sans-first:1.92 18:00:48 INFO - PID 29954 | Values: 95.0 97.0 94.0 94.0 94.0 94.0 94.0 99.0 94.0 93.0 18:00:48 INFO - PID 29954 | 18:00:48 INFO - PID 29954 | [#8] json-parse-financial Cycles:10 Average:46.00 Median:46.00 stddev:0.94 (2.0%) stddev-sans-first:1.00 18:00:48 INFO - PID 29954 | Values: 46.0 45.0 45.0 46.0 46.0 46.0 47.0 46.0 45.0 48.0 18:00:48 INFO - PID 29954 | 18:00:48 INFO - PID 29954 | [#9] json-stringify-tinderbox Cycles:10 Average:51.10 Median:51.00 stddev:0.32 (0.6%) stddev-sans-first:0.33 18:00:48 INFO - PID 29954 | Values: 51.0 51.0 51.0 51.0 51.0 51.0 52.0 51.0 51.0 51.0 18:00:48 INFO - PID 29954 | 18:00:48 INFO - PID 29954 | [#10] stanford-crypto-aes Cycles:10 Average:75.40 Median:76.00 stddev:1.71 (2.3%) stddev-sans-first:1.58 18:00:48 INFO - PID 29954 | Values: 73.0 73.0 76.0 77.0 77.0 76.0 75.0 74.0 75.0 78.0 18:00:48 INFO - PID 29954 | 18:00:48 INFO - PID 29954 | [#11] stanford-crypto-ccm Cycles:10 Average:124.70 Median:122.00 stddev:18.49 (15.2%) stddev-sans-first:19.60 18:00:48 INFO - PID 29954 | Values: 123.0 120.0 114.0 121.0 114.0 117.0 114.0 125.0 123.0 176.0 18:00:48 INFO - PID 29954 | 18:00:48 INFO - PID 29954 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.30 Median:168.00 stddev:5.93 (3.5%) stddev-sans-first:6.27 18:00:48 INFO - PID 29954 | Values: 167.0 164.0 174.0 176.0 167.0 163.0 169.0 178.0 165.0 160.0 18:00:48 INFO - PID 29954 | 18:00:48 INFO - PID 29954 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.90 Median:62.50 stddev:1.66 (2.7%) stddev-sans-first:1.76 18:00:48 INFO - PID 29954 | Values: 62.0 63.0 61.0 63.0 60.0 60.0 62.0 63.0 65.0 60.0 18:00:48 INFO - PID 29954 | -------- Summary: end -------- 18:00:48 INFO - PID 29954 | 18:00:48 INFO - PID 29954 | 18:00:48 INFO - PID 29954 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x150082,name=PBrowser::Msg_Destroy) Closed channel: cannot send/recv 18:00:48 INFO - PID 29954 | 18:00:48 INFO - PID 29954 | 18:00:48 INFO - PID 29954 | ###!!! [Child][MessageChannel] Error: (msgtype=0x150001,name=PBrowser::Msg_AsyncMessage) Closed channel: cannot send/recv 18:00:48 INFO - PID 29954 | 18:00:48 INFO - PID 29954 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 18:00:48 INFO - TEST-INFO | 29954: exit 0 18:00:49 INFO - TEST-OK | kraken | took 60123ms 18:00:49 INFO - SUITE-END | took 1168s 18:00:49 INFO - Completed test suite (00:19:29) 18:00:49 INFO - javascript benchmark 18:00:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8899.692234537313, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3767.566729826071, 3824.7322687411893, 3864.207837393334, 3872.4772155758974, 3882.4176373543964, 6092.299385570655, 6095.359987201341, 6135.447809697126, 6167.167432396625, 6182.505399568035, 6069.908951365733, 6136.110264011716, 6145.446909778119, 6167.444929956303, 6232.657203853786, 5499.890002199953, 5549.528290095347, 5553.750081246354, 5566.471185237396, 5586.497215250627, 310.8969048556272, 5465.344158700961, 5478.45215478453, 5633.464820842034, 5635.6618602883755, 5473.17902314654, 5538.6122971392015, 5614.9157762633595, 5626.971865140689, 5645.463680950324, 5525.917111243334, 5546.805861794818, 5591.440855914417, 5607.551395888319, 5610.18652295419, 5513.669179849222, 5523.088690366085, 5595.916061259084, 5599.4120617335, 5602.579806514487, 6094.146819445281, 6138.600990935575, 6149.600275982047, 6163.660998645073, 6190.164327815777, 6506.446952009038, 6591.340865913418, 6602.306757790411, 6602.834929126762, 6726.93273067268, 6527.347265273482, 6632.038354438628, 6632.971889357157, 6670.3329667033395, 6725.428338591177, 6193.81418557444, 6274.623522588659, 6284.7486100555925, 6287.182666253403, 6289.622622642611, 6813.591184528944, 6825.112735344473, 6828.658567071627, 6912.239653638096, 6916.6541672916155, 6468.773592924225, 6554.475641948633, 6564.212294524687, 6602.1747281589805, 6652.401283884474, 6705.966470167618, 6732.057511948331, 6752.864942701119, 6778.898316525256, 6779.220389655155, 6578.407943285128, 6600.702968366435, 6619.900701489481, 6641.369069938348, 6700.899486507707, 6511.609303441809, 6612.933870661232, 6687.933120668731, 6694.531382803254, 6695.966520167465, 4955.1823949048, 4992.550670439678, 5010.824621138243, 5026.045051440215, 5028.522290382408, 4617.8383756568355, 4643.257078867365, 4671.089137618132, 4677.836275730333, 4701.670883038223, 6153.907691384633, 6164.496291826061, 6168.845778855564, 6242.812715618538, 6260.874782504325, 6512.185976752906, 6621.9006714899315, 6643.136392269071, 6723.058771771955, 6727.899081513781, 6130.049842274455, 6140.263168419819, 6164.0, 6198.535109866778, 6237.625742455467, 5521.503064724114, 5547.694876781735, 5585.664860108406, 5591.664500130005, 5596.0, 6873.140857392826, 6947.478939079489, 7039.120109986252, 7040.5071644984355, 7073.540219885691, 6497.155369801895, 6511.153550038464, 6591.143151390289, 6605.174353205849, 6614.074029635759, 6915.308469153045, 6958.0, 6992.16094068715, 7012.0, 7020.403265722471, 6497.0, 6515.609063456208, 6600.80197594073, 6601.207855057424, 6645.368689974444, 6625.271220165681, 6641.070250165078, 6701.463882889455, 6737.326267373223, 6738.73045078211, 6410.903836442364, 6480.384363485461, 6503.902441463287, 6506.4469520091325, 6512.185976752906, 6391.6258004529245, 6395.328490508616, 6479.287278399278, 6498.740050397932, 6503.837404064936, 6303.716332765129, 6343.111964324906, 6346.365363463617, 6404.967975160094, 6412.871742565029, 6435.613863168225, 6438.6136831790245, 6445.516586255956, 6475.838104047437, 6508.08886755864, 6309.526785491014, 6315.179026726496, 6398.87202255943, 6412.807615771534, 6413.0701048348665], "value": 6076.049518594294, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [921.4010892919601, 941.8398872191731, 968.7239136846, 995.9103680668738, 998.1515711645103, 42061.369079463795, 42963.35554966678, 43012.78493607535, 43069.35395969059, 43102.353464698055, 39006.8049659752, 39313.0, 39367.0, 39406.60593394065, 39430.60569394305, 7101.715931362753, 7219.566825990431, 7221.855562888739, 7225.530340527849, 7226.421886249087, 7102.112235970504, 7176.246494118121, 7184.497085204038, 7185.173705023937, 7185.497015208937, 7707.190744971781, 7907.327877130422, 7908.090569584485, 7909.090454597708, 7909.24862138096, 7806.258405451473, 7859.410544209207, 7863.52818830872, 7866.41001924855, 7867.331276841475, 7621.275978782007, 7683.500572462828, 7808.141104478503, 7828.060632724053, 7835.255650713173, 39703.20593588141, 40065.39901901474, 40091.7995410024, 40196.598034019575, 40213.19573608541, 3421.264428147935, 3468.1676397664633, 3475.582930048385, 3476.7566270361085, 3481.425564781808, 32192.678073219202, 32249.51625725616, 32270.031899043068, 32292.354152917043, 32318.19204519906, 5243.423223445456, 5267.104592219332, 5302.363716354023, 5306.389765176977, 5314.92027619586, 205232.0, 205286.0, 205524.94475055207, 205654.0, 206017.96991015098, 49162.75418622884, 49325.26012109821, 49348.50651493511, 49401.25898111531, 49417.0, 50374.0, 50399.74800125976, 50525.0, 50534.24198637023, 50730.49269507331, 15711.921440392953, 15722.68554628901, 15787.447439339569, 15838.841611583966, 15842.52472425829, 12801.103922725506, 12823.743525129632, 12824.615261541981, 12834.80747788784, 12841.293728844816, 14125.223112728692, 14182.432702691984, 14458.710825783426, 14471.638209044859, 14564.781528277084, 5701.2018317435595, 5762.279715035621, 5781.4218578141845, 5801.564882633819, 5829.36777702244, 1029.4389557691077, 1062.877769056553, 1064.180580952662, 1064.414571985405, 1066.3655125200494, 23587.0, 23657.29028129159, 23759.287221383387, 23836.16573419922, 24048.87975560111, 1144.181909934401, 1145.856767904012, 1146.2492067695673, 1165.3648761425043, 1176.2589568571916, 12552.372381380894, 12771.680707982376, 16811.91594042022, 17083.658326833392, 17131.0, 270018.0, 270589.0, 270769.0, 271713.0, 271954.0, 60325.69837150786, 60505.39494605086, 60543.39456605377, 60656.393436065955, 60784.0, 1495.7008598280388, 1499.955091164937, 1513.9091654500764, 1525.6643538421529, 1531.5788158256792, 27887.721122788513, 28293.858530707214, 28530.286742831595, 28577.28556786097, 28653.70770338326, 40166.0, 40562.18875622412, 40605.0, 40615.59384406118, 40692.389614156404, 239857.0, 240173.0, 240229.0, 240404.0, 240471.0, 35441.46837797487, 35553.64446355607, 35768.0, 35911.10222244465, 35947.46078808768, 44628.55371446244, 44762.0, 45224.547754522035, 45294.0, 45397.773011134734, 31993.520097198096, 32118.197045073124, 34348.14129646779, 35500.46749298711, 35896.46155307725, 34205.65794342025, 34586.0, 34602.82698586592, 34676.0, 35263.0, 40371.0, 40416.79791601023, 40672.79663601663, 40691.79654101829, 40834.1833163341, 34265.0, 34364.0, 34399.828000860834, 34441.48337774885, 35000.47499287462, 24482.51034979255, 25473.363165921, 26115.608265875646, 26155.607665884647, 26694.332641684112], "value": 18050.09154690727, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [580.7851095094816, 589.8053642298042, 598.5301538292441, 600.6066026752477, 610.5817515002224, 22691.0, 23526.0, 24188.15341463049, 24223.75776242237, 24270.514589708197, 24238.03047878087, 24669.383265418375, 24801.503969920635, 24809.875950620266, 24842.130525431614, 6390.71241794118, 6518.902216466757, 6526.184226971629, 6526.934730652681, 6529.281779004329, 6122.54080943931, 6361.332060133689, 6370.49036077115, 6438.323975982525, 6507.772227972022, 6325.873482530346, 6327.873442531147, 6329.651869147195, 6330.778422755205, 6331.746730130789, 6341.2707538633185, 6347.619142851444, 6348.079528468346, 6348.682565871711, 6351.26960399553, 5920.644761314292, 5926.0, 5927.407259274081, 5939.0, 5944.851378715523, 30104.0, 30385.0, 30712.692873071206, 30945.226369340722, 30949.845250773826, 2146.6887301341376, 2249.572581209581, 2250.381145185087, 2250.6961560189493, 2250.932472025842, 19211.807881921282, 19656.0, 20781.688274675893, 20819.791802081938, 20839.479013024644, 2469.3826543364157, 2475.653408522808, 2516.4338023944647, 2522.990803678525, 2537.949241015188, 146696.0, 153951.2302438492, 154070.0, 154083.0, 154380.0, 15441.382344706086, 15604.843951560566, 15620.297086631128, 16036.198190090448, 16048.67902641964, 25257.242282731546, 25304.0, 25311.0, 25338.493230135664, 25384.36539086501, 10285.331453455501, 10294.124999374988, 10306.381617102998, 10417.479126043667, 10593.735156620993, 7769.417293702995, 8318.292945099613, 8640.30877529796, 9336.95331523338, 9542.379745316532, 9649.324547281763, 9895.901040989498, 9991.400515969066, 10030.949845250872, 10041.548130334153, 2848.643919510061, 2866.498362786504, 2884.5961565380862, 2893.667228268776, 2964.5256758918467, 997.9600815967425, 1020.8366661334151, 1023.2428003277521, 1025.4821315235758, 1026.1431704526804, 20551.691724624143, 20609.587808243752, 20711.0, 20805.063772129986, 21296.25463108784, 1078.4984981983416, 1083.2092572422018, 1087.4019289390803, 1087.6465148826662, 1087.9020888120108, 10742.624008159833, 11255.94372028151, 11414.086873050303, 11564.537418503165, 13083.476660933646, 672751.0, 678831.0, 680243.0, 681323.0, 685543.0, 132625.336873315, 135778.0, 137094.0, 137487.0, 143152.0, 1248.862625111237, 1275.4961790092862, 1306.764782339188, 1310.3775706539318, 1316.5655333739842, 21299.78700212978, 21314.147434102462, 21416.78583214148, 21423.250186243407, 21431.357059288246, 62850.0, 63140.68429657822, 63193.36806631875, 63469.682651586445, 64577.67711161414, 79539.60230199044, 79877.20122798698, 80297.59851200707, 80333.59833200797, 80867.19132808596, 12708.3010434427, 13259.867401325862, 14660.56018319452, 15135.545933622008, 15213.391464341303, 23966.041358345472, 24349.634755479037, 24436.389090272885, 24451.633225501988, 24554.140605078737, 17647.0, 17850.91074544619, 18007.00961447133, 18031.819681803016, 18040.909795450938, 16008.919955400148, 16053.759193611872, 16492.752608710638, 16518.339266429208, 17296.048717320667, 18200.635987280446, 19197.040147992266, 19406.320778772675, 19460.0, 19573.804261957768, 14684.77972830387, 15417.383304667688, 15476.0, 15479.84520154829, 15648.530544083696, 19342.129604167563, 19557.11992960292, 19660.90169549143, 19714.309999149962, 19829.30597429083], "value": 12582.142613082167, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1421.331973972233, 1457.1694134343415, 1459.6642772162402, 1478.2017710436357, 1504.240358618897, 15770.211489425526, 16355.427560035401, 16443.75334369984, 16477.093759843203, 16484.093374864377, 16643.916780416082, 16907.0, 16920.915395423035, 16931.661366772656, 16938.83061169388, 2809.269589906624, 2848.9002884899032, 2851.8574071296457, 2852.0160544612077, 2853.6004959305715, 2679.075718876994, 2752.229375774786, 2758.0760445250867, 2758.475889580983, 2758.600002999564, 2645.9603105953424, 2684.060578797415, 2684.6644169478814, 2695.865206739665, 2702.3514356554383, 2670.1055146525937, 2672.2784848091005, 2675.103840213531, 2687.193841847448, 2690.3946612012337, 2563.6410902473667, 2582.5738753105716, 2590.8056895732893, 2595.2733234694315, 2599.298189488846, 15676.764848527282, 15912.283947222402, 15918.60203494922, 15931.601709957344, 15990.520284391487, 7718.575478348688, 8062.193780621949, 8063.0, 8063.758087257392, 8063.879041814377, 5205.453427390145, 5441.129419292894, 5526.778928842841, 5529.917051244234, 5569.972150139264, 2025.7163997040427, 2057.1565658080117, 2083.9270625528034, 2113.630114729916, 2118.5127420693325, 26506.867465662548, 26663.20010399691, 26797.06210282631, 26815.865920670272, 26843.19470415891, 6617.404433600903, 6725.932740672629, 6758.695858686371, 6826.965865170642, 6892.689828957709, 17668.11659417024, 17695.46913592594, 17704.645907081787, 17718.734218986727, 17728.82271177272, 7615.695372185161, 7777.922220777833, 7780.1052878919645, 7781.105172905075, 7800.985871836739, 5914.172015917775, 6039.516838652898, 6427.357264273535, 7296.927030729731, 7303.233160518175, 5568.16477528374, 5689.544836413077, 5704.172894930211, 5730.054541000688, 5764.798232061858, 1651.6614094110919, 1666.3334666133644, 1669.3990163541116, 1687.2829047654698, 1692.035539742335, 941.5668792355456, 970.1365784451843, 980.8136454073704, 985.0395864032654, 1010.5503051142172, 9056.592453339616, 9210.815783684422, 9351.205147562398, 9409.435433873852, 9496.240300775922, 1032.4476405123373, 1056.3556230699267, 1063.2344711807486, 1070.3417398300146, 1080.778440419712, 5802.65184088956, 5825.0, 5917.230760001173, 6065.5450841187085, 6294.213223347082, 23377.649335259986, 23447.41381465477, 24403.26790196297, 24592.385190370383, 24604.876975615367, 23192.884035579715, 23197.188098416475, 23339.76660233376, 23339.766602334097, 23439.179628712915, 12344.938275308567, 12549.686257843627, 12696.365181740875, 12781.0, 12797.744045119045, 9236.0, 9742.415455072718, 9771.267154963549, 9919.355241909252, 10154.136898363722, 19870.205191792167, 20054.899725501862, 20180.091895865015, 20540.281090161774, 20570.280040198522, 20085.0, 20211.494712631713, 20292.79707202909, 20510.692339615216, 20664.79335206629, 12954.0, 13314.93342533281, 13422.932885335511, 13424.93287533556, 13427.19436833793, 14935.701285974003, 15089.24553772285, 15090.924545377204, 15094.622634434227, 15097.47158849435, 12027.15809893299, 12064.336461494702, 12326.322052286852, 12406.62780116598, 12451.626451206479, 11981.041516678819, 12220.0, 12240.449179786752, 12350.320732359807, 12563.18339307942, 10478.842817357898, 10494.265401421828, 10499.94750026245, 10517.9474102629, 10536.104431123134, 8212.384071194565, 8359.122292159236, 8422.24199822019, 8422.873656895028, 8463.703770368007, 8226.05400378964, 8239.340852731886, 8318.251357377865, 8331.833363332578, 8335.416520843482], "value": 7114.491972051405, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [544.7358031354794, 552.2075821196582, 553.4437889920629, 565.8557067947672, 575.8848230353927, 6165.260168779747, 6203.914314994875, 6215.508278013278, 6224.564280500367, 6254.655993920344, 6095.238095238095, 6118.174046503721, 6126.540509461786, 6148.292946311176, 6168.845778855531, 5070.29015937769, 5071.949280507203, 5085.618578606619, 5114.386273647167, 5114.846554603349, 4825.686330388531, 5041.369828771385, 5092.872678183056, 5093.2105523643895, 5125.718085505296, 4891.657583969123, 4906.484819093997, 4919.0, 4931.630127740415, 4937.827176048839, 4933.925991110101, 4938.827141050064, 4945.897993352846, 4950.6782059166035, 4969.577585905166, 4397.956020439787, 4457.420535330419, 4475.216837053503, 4477.3731677565165, 4501.177023305567, 6039.305479869783, 6063.302720187191, 6069.15031895535, 6109.725062372159, 6125.632462052291, 5726.484616384545, 5759.539236861041, 5760.8847823043725, 5778.797742079049, 5783.224052454803, 6572.8356791080605, 6580.638064906429, 6583.0, 6591.637459939701, 6598.802035938881, 4920.532549407836, 4923.138450771136, 4933.605311575066, 4937.259411088329, 4939.6789208701675, 6540.70566824494, 6655.966720166368, 6719.899201511981, 6805.591664500146, 6865.0, 5061.493850614983, 5067.670601410897, 5080.552042667822, 5088.211327244283, 5090.821821236239, 5166.121759300928, 5166.147585648326, 5166.579190722507, 5172.482751724872, 5179.92230116541, 5634.971825140848, 5689.800856969986, 5694.9179655865255, 5701.059325211377, 5733.082706766897, 6566.540342176002, 6596.868062638816, 6604.306547812506, 6604.537682362285, 6633.900491492632, 1766.2052076565597, 1774.8668849836056, 1776.1563257452865, 1787.8390944814769, 1790.4091649755549, 1201.141184053406, 1234.8456442944632, 1249.5876360800914, 1256.4534427524056, 1263.7093468502112, 5936.584439089309, 5956.970215148896, 5998.070299103646, 6081.726322315506, 6148.231471066117, 6538.8365290868105, 6586.748517781606, 6631.33686631333, 6661.0, 6666.899996500057, 5993.0, 6001.2498437695285, 6005.189299444606, 6075.3924607539775, 6094.0, 3413.9246137466616, 3441.328940856559, 3445.0, 3463.2337507871166, 3492.511048453219, 6701.135492170319, 6775.593464392054, 6787.219469760942, 6882.724691012403, 6946.756863509854, 6669.46644268467, 6702.430293425016, 6809.1488563928515, 6813.659317034128, 6828.965855170792, 6888.448924086061, 6912.688928998106, 6961.547499412522, 6999.965000174967, 7018.929810701828, 6521.445677117498, 6546.607203567801, 6563.278039415565, 6572.155289155706, 6620.3710647488415, 6511.218653761579, 6549.934500654933, 6567.274581049002, 6621.867562648624, 6644.60132392058, 6958.338957799001, 6985.44116470671, 7007.264237255014, 7014.158301003912, 7026.9648651756415, 5050.570701490267, 5053.317802096817, 5055.823046193365, 5092.516210959953, 5097.541221290102, 6479.287278399466, 6554.542910820497, 6577.276499585138, 6670.332966703485, 6707.65232168737, 6178.227721534809, 6339.746410143727, 6411.358864113738, 6417.39034791694, 6430.488835123836, 6277.529185311028, 6296.150019747459, 6309.684515774285, 6421.5825971311715, 6455.741770329134, 6263.4362907338555, 6317.273513546001, 6334.524910631813, 6384.361563843764, 6444.9355506444335, 6470.2853743757005, 6472.870542589216, 6496.220453545605, 6496.642684652389, 6523.11937888379, 6229.065640153832, 6262.812115636538, 6275.278342990615, 6316.494680425463, 6335.936640633535], "value": 5090.707899055258, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [933.5845548730813, 951.8143961927425, 976.858355538447, 982.1259079419314, 989.9604015839367, 16861.0, 17963.28146874125, 18002.819971800294, 18129.0, 18545.165467553958, 21218.257360992367, 21856.0, 21876.45308867279, 21885.12459501618, 21893.0, 1061.6814955513335, 1097.6652121103061, 1099.1042300525046, 1099.1316859680842, 1100.8954149355798, 1011.7774089700291, 1068.4817863336275, 1081.4646749858791, 1095.8301463273206, 1098.1544210957559, 1125.4991528769701, 1141.520561364225, 1141.697450175704, 1141.78306121837, 1142.3774043146504, 1130.7060164357285, 1136.023020202625, 1140.3044143072677, 1140.5779861451317, 1142.0406858239119, 831.9001719793603, 836.6946064686346, 836.9288610468118, 837.2883049408015, 837.8240569480416, 19987.0, 19996.90001549983, 20311.89844050785, 20420.795792042038, 21268.25561105354, 21898.671519927215, 21952.89023554888, 22057.22799702003, 22117.66823497649, 22549.887250563806, 16995.150242487827, 17238.138093095422, 17482.125893705263, 17772.822271777248, 17879.553011174696, 3902.453656488094, 3935.0162459385156, 3940.5271367435803, 3941.487606611151, 3941.507311586052, 143682.28158859242, 143814.0, 143979.0, 144420.2778986109, 144422.0, 16840.157992100347, 17132.657346852993, 17494.0, 17574.38489652856, 17574.736378954327, 32977.0, 33016.83491582527, 33613.0, 33615.49576756351, 33817.15457113592, 7931.325837303893, 7948.920510794934, 8100.513969161869, 8114.918850811417, 8134.918650813534, 4028.617281358266, 4095.4266402703647, 4122.896927576775, 4125.133721918431, 4126.834926602963, 5268.578513718893, 5339.599530035185, 5386.811461598825, 5439.129739241703, 5444.992676354807, 1026.2610920137488, 1042.8800687920834, 1050.9737256568494, 1071.924965252425, 1073.7637719701654, 723.4754802767951, 736.3556887723242, 746.06369006896, 756.3042001358763, 762.7025460070577, 12342.01263898886, 13106.475740970445, 13395.196288222738, 13602.727945441036, 13996.650083747987, 728.5737843361587, 740.637087826961, 741.1513816679872, 760.1524300405008, 761.5316580303074, 6008.068749343859, 6071.9981203101, 6088.238970128734, 6138.1099740537375, 6197.163382943335, 126258.0, 127035.0, 128325.0, 131424.0, 131580.0, 110197.44901275443, 111327.44336278428, 111881.44059279651, 114107.42946285216, 116353.0, 100656.0, 101349.0, 102030.48984755177, 102922.0, 103093.0, 10912.345259284468, 11084.889151108386, 11089.233598528881, 11256.21206515536, 11414.885851141715, 50031.74984125056, 50818.491815081376, 51500.48499514957, 52921.0, 53705.0, 80075.0, 80695.0, 81372.59313703631, 83263.58368208363, 83760.0, 20661.380158595268, 21165.0, 21255.468613284793, 21307.46731331729, 21310.254141104986, 21426.357209283746, 23126.537469250856, 23154.652680209474, 23184.884075579514, 23891.761082388955, 21130.26044088511, 21189.788102118782, 21335.67996480023, 21666.458338541663, 21769.0, 20779.584408311446, 21441.035153417823, 21450.24924127648, 21467.926603669443, 21668.24161154352, 19848.801511984697, 20798.37604871856, 20888.0, 21125.78874211238, 21202.893985529972, 14253.0, 14858.257087145383, 15254.1610211435, 15593.220338983232, 15652.686946260783, 15407.152606606744, 15690.686186276438, 15844.44544440939, 15891.205439727735, 16321.918390407973], "value": 9941.347298557288, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1472.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 106.0, 98.0, 105.0, 105.0, 106.0, 108.0, 97.0, 105.0, 107.0], "value": 103.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 123.0, 145.0, 174.0, 116.0, 146.0, 142.0, 114.0, 163.0, 113.0], "value": 138.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 165.0, 161.0, 162.0, 162.0, 162.0, 161.0, 161.0, 168.0, 170.0], "value": 163.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 72.0, 181.0, 74.0, 73.0, 72.0, 87.0, 93.0, 75.0], "value": 87.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 129.0, 78.0, 78.0, 79.0, 132.0, 78.0, 78.0, 122.0], "value": 93.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 114.0, 113.0, 114.0, 115.0, 114.0, 114.0, 113.0, 113.0], "value": 113.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 151.0, 150.0, 152.0, 149.0, 149.0, 149.0, 150.0, 157.0], "value": 150.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 94.0, 94.0, 94.0, 94.0, 94.0, 99.0, 94.0, 93.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [46.0, 45.0, 45.0, 46.0, 46.0, 46.0, 47.0, 46.0, 45.0, 48.0], "value": 46.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 51.0, 51.0, 51.0, 51.0, 52.0, 51.0, 51.0, 51.0], "value": 51.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 76.0, 77.0, 77.0, 76.0, 75.0, 74.0, 75.0, 78.0], "value": 75.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 120.0, 114.0, 121.0, 114.0, 117.0, 114.0, 125.0, 123.0, 176.0], "value": 124.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 164.0, 174.0, 176.0, 167.0, 163.0, 169.0, 178.0, 165.0, 160.0], "value": 168.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 61.0, 63.0, 60.0, 60.0, 62.0, 63.0, 65.0, 60.0], "value": 61.9, "unit": "score"}]}]} 18:00:49 INFO - Return code: 0 18:00:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:00:49 INFO - # TBPL SUCCESS # 18:00:49 INFO - Running post-action listener: _package_coverage_data 18:00:49 INFO - Running post-action listener: _resource_record_post_action 18:00:49 INFO - [mozharness: 2017-08-26 01:00:49.643935Z] Finished run-tests step (success) 18:00:49 INFO - Running post-run listener: _resource_record_post_run 18:00:49 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 425189376; Read time: 12; Write time: 346956 18:00:49 INFO - TinderboxPrint: CPU usage
13.1% 18:00:49 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 18:00:49 INFO - TinderboxPrint: I/O write bytes / time
425,189,376 / 346,956 18:00:49 INFO - TinderboxPrint: CPU idle
8,226.7 (86.9%) 18:00:49 INFO - TinderboxPrint: CPU user
1,188.1 (12.6%) 18:00:49 INFO - TinderboxPrint: Swap in / out
0 / 0 18:00:49 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 105418752; Read time: 0; Write time: 101864 18:00:49 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 18:00:49 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 4096; Write bytes: 319770624; Read time: 12; Write time: 245092 18:00:50 INFO - Running post-run listener: _upload_blobber_files 18:00:50 INFO - Blob upload gear active. 18:00:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:00:50 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 18:00:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:00:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:00:50 INFO - (blobuploader) - INFO - Open directory for files ... 18:00:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:00:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:00:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:00:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:00:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:00:57 INFO - (blobuploader) - INFO - Done attempting. 18:00:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:00:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:00:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:00:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:00:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:00:58 INFO - (blobuploader) - INFO - Done attempting. 18:00:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:00:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:00:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:00:59 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:00:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:00:59 INFO - (blobuploader) - INFO - Done attempting. 18:00:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:00:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:00:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:01:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:01:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:01:00 INFO - (blobuploader) - INFO - Done attempting. 18:01:00 INFO - (blobuploader) - INFO - Iteration through files over. 18:01:00 INFO - Return code: 0 18:01:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:01:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:01:00 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5f2fb9824e80340e476497683ba652f6399f9efa3adbf9ce111e0bda0bdc285d6d6bdff9bbe412d31c7a8dc9f14ded592998f1a0c902a9f911fddd891d49f278", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f8bb226853e7eaed517475d77ab75f86525b141f00ee3a306a4ce17b53caae219ebb7ce3e44745dec328b51c53d937c6cc65213e01f47c69e60f02ca8f72caaa", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d231d726d5aa3446a4c56f0f8406b0d368c81865d8f0e7cfe1375b0f173534cf9cb660e69434bac9d997750b432bab2504d2bf4fdfd2e39f72dda3f4ff3a1508", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8707c730d9fcdc1da59d169a2b7d46eaac3b360f3afc1bc2a599fdad2d92fc2d505a279cc3e9e40abc5eb47e5f9baee8e12d038929f18248fe414f46611b3fa4"} 18:01:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:01:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:01:00 INFO - Contents: 18:01:00 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5f2fb9824e80340e476497683ba652f6399f9efa3adbf9ce111e0bda0bdc285d6d6bdff9bbe412d31c7a8dc9f14ded592998f1a0c902a9f911fddd891d49f278", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f8bb226853e7eaed517475d77ab75f86525b141f00ee3a306a4ce17b53caae219ebb7ce3e44745dec328b51c53d937c6cc65213e01f47c69e60f02ca8f72caaa", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d231d726d5aa3446a4c56f0f8406b0d368c81865d8f0e7cfe1375b0f173534cf9cb660e69434bac9d997750b432bab2504d2bf4fdfd2e39f72dda3f4ff3a1508", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8707c730d9fcdc1da59d169a2b7d46eaac3b360f3afc1bc2a599fdad2d92fc2d505a279cc3e9e40abc5eb47e5f9baee8e12d038929f18248fe414f46611b3fa4"} 18:01:00 INFO - Running post-run listener: copy_logs_to_upload_dir 18:01:00 INFO - Copying logs to upload dir... 18:01:00 INFO - mkdir: /builds/slave/test/build/upload/logs 18:01:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.640682 ========= master_lag: 0.08 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-08-25 18:01:00.577063) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-25 18:01:00.581591) ========= 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=232498196343f89f466a4a9a000001c8-1503708009.729582-841113133 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5f2fb9824e80340e476497683ba652f6399f9efa3adbf9ce111e0bda0bdc285d6d6bdff9bbe412d31c7a8dc9f14ded592998f1a0c902a9f911fddd891d49f278", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f8bb226853e7eaed517475d77ab75f86525b141f00ee3a306a4ce17b53caae219ebb7ce3e44745dec328b51c53d937c6cc65213e01f47c69e60f02ca8f72caaa", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d231d726d5aa3446a4c56f0f8406b0d368c81865d8f0e7cfe1375b0f173534cf9cb660e69434bac9d997750b432bab2504d2bf4fdfd2e39f72dda3f4ff3a1508", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8707c730d9fcdc1da59d169a2b7d46eaac3b360f3afc1bc2a599fdad2d92fc2d505a279cc3e9e40abc5eb47e5f9baee8e12d038929f18248fe414f46611b3fa4"} build_url:https://queue.taskcluster.net/v1/task/WU6AbHM2QRaABo2Jy31ApA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011361 build_url: 'https://queue.taskcluster.net/v1/task/WU6AbHM2QRaABo2Jy31ApA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5f2fb9824e80340e476497683ba652f6399f9efa3adbf9ce111e0bda0bdc285d6d6bdff9bbe412d31c7a8dc9f14ded592998f1a0c902a9f911fddd891d49f278", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f8bb226853e7eaed517475d77ab75f86525b141f00ee3a306a4ce17b53caae219ebb7ce3e44745dec328b51c53d937c6cc65213e01f47c69e60f02ca8f72caaa", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d231d726d5aa3446a4c56f0f8406b0d368c81865d8f0e7cfe1375b0f173534cf9cb660e69434bac9d997750b432bab2504d2bf4fdfd2e39f72dda3f4ff3a1508", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8707c730d9fcdc1da59d169a2b7d46eaac3b360f3afc1bc2a599fdad2d92fc2d505a279cc3e9e40abc5eb47e5f9baee8e12d038929f18248fe414f46611b3fa4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-25 18:01:00.615846) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-25 18:01:00.616233) ========= 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=232498196343f89f466a4a9a000001c8-1503708009.729582-841113133 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004423 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-25 18:01:00.695987) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-25 18:01:00.699388) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-25 18:01:00.699751) ========= ========= Total master_lag: 0.25 =========