builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-056 starttime: 1504825039.86 results: success (0) revision: b4c1ad9565ee9d00d96501c4a83083daf25c1413 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-07 15:57:19.858679) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-07 15:57:19.859152) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-07 15:57:19.859427) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-07 15:57:19.875777) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 15:57:19.876194) ========= 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=52faae308a556c440401f8e5000001e8-1504825039.36694-854300185 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-07 15:57:19-- 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% 105M=0s 2017-09-07 15:57:19 (105 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.126926 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 15:57:20.018777) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 15:57:20.019197) ========= 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=52faae308a556c440401f8e5000001e8-1504825039.36694-854300185 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023889 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 15:57:20.069100) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-07 15:57:20.069431) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b4c1ad9565ee9d00d96501c4a83083daf25c1413 --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 b4c1ad9565ee9d00d96501c4a83083daf25c1413 --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=52faae308a556c440401f8e5000001e8-1504825039.36694-854300185 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-07 15:57:20,099 truncating revision to first 12 chars 2017-09-07 15:57:20,099 Setting DEBUG logging. 2017-09-07 15:57:20,099 attempt 1/10 2017-09-07 15:57:20,100 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b4c1ad9565ee?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-07 15:57:21,310 unpacking tar archive at: mozilla-central-b4c1ad9565ee/testing/mozharness/ program finished with exit code 0 elapsedTime=1.543509 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-07 15:57:21.629212) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-07 15:57:21.629534) ========= script_repo_revision: b4c1ad9565ee9d00d96501c4a83083daf25c1413 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-07 15:57:21.629900) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-07 15:57:21.630194) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-07 15:57:21.642968) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2017-09-07 15:57:21.643364) ========= /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=52faae308a556c440401f8e5000001e8-1504825039.36694-854300185 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:57:21 INFO - MultiFileLogger online at 20170907 15:57:21 in /builds/slave/test 15:57:21 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 15:57:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:57:21 INFO - {'append_to_log': False, 15:57:21 INFO - 'base_work_dir': '/builds/slave/test', 15:57:21 INFO - 'blob_upload_branch': 'Firefox', 15:57:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:57:21 INFO - 'branch': 'Firefox', 15:57:21 INFO - 'buildbot_json_path': 'buildprops.json', 15:57:21 INFO - 'code_coverage': False, 15:57:21 INFO - 'config_files': ('talos/linux_config.py',), 15:57:21 INFO - 'default_actions': ('clobber', 15:57:21 INFO - 'read-buildbot-config', 15:57:21 INFO - 'download-and-extract', 15:57:21 INFO - 'populate-webroot', 15:57:21 INFO - 'create-virtualenv', 15:57:21 INFO - 'install', 15:57:21 INFO - 'setup-mitmproxy', 15:57:21 INFO - 'run-tests'), 15:57:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:57:21 INFO - 'disable_ccov_upload': False, 15:57:21 INFO - 'disable_stylo': False, 15:57:21 INFO - 'download_minidump_stackwalk': True, 15:57:21 INFO - 'download_symbols': 'ondemand', 15:57:21 INFO - 'enable_stylo': False, 15:57:21 INFO - 'enable_webrender': False, 15:57:21 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 15:57:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:57:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:57:21 INFO - 'gecko_profile': False, 15:57:21 INFO - 'gecko_profile_interval': 0, 15:57:21 INFO - 'installer_path': 'installer.exe', 15:57:21 INFO - 'log_level': 'info', 15:57:21 INFO - 'log_name': 'talos', 15:57:21 INFO - 'log_to_console': True, 15:57:21 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:57:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:57:21 INFO - 'opt_config_files': (), 15:57:21 INFO - 'pip_index': False, 15:57:21 INFO - 'suite': 'dromaeojs-e10s', 15:57:21 INFO - 'system_bits': '32', 15:57:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:57:21 INFO - 'title': 'talos-linux64-ix-056', 15:57:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:57:21 INFO - 'use_talos_json': True, 15:57:21 INFO - 'verify': 'False', 15:57:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:57:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:57:21 INFO - 'work_dir': 'build'} 15:57:21 INFO - [mozharness: 2017-09-07 22:57:21.813859Z] Running clobber step. 15:57:21 INFO - Running pre-action listener: _resource_record_pre_action 15:57:21 INFO - Running main action method: clobber 15:57:21 INFO - rmtree: /builds/slave/test/build 15:57:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:57:22 INFO - Running post-action listener: _resource_record_post_action 15:57:22 INFO - [mozharness: 2017-09-07 22:57:22.869978Z] Finished clobber step (success) 15:57:22 INFO - [mozharness: 2017-09-07 22:57:22.870076Z] Running read-buildbot-config step. 15:57:22 INFO - Running pre-action listener: _resource_record_pre_action 15:57:22 INFO - Running main action method: read_buildbot_config 15:57:22 INFO - Using buildbot properties: 15:57:22 INFO - { 15:57:22 INFO - "project": "", 15:57:22 INFO - "product": "firefox", 15:57:22 INFO - "who": "archaeopteryx@coole-files.de", 15:57:22 INFO - "installer_path": "public/build/target.tar.bz2", 15:57:22 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 15:57:22 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 15:57:22 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 15:57:22 INFO - "stage_platform": "linux64-stylosequential", 15:57:22 INFO - "basedir": "/builds/slave/test", 15:57:22 INFO - "buildnumber": 236, 15:57:22 INFO - "platform": "ubuntu64_hw_styloseq", 15:57:22 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:57:22 INFO - "slavebuilddir": "test", 15:57:22 INFO - "taskId": "fGStnulURcq0-EYoM7jsKA", 15:57:22 INFO - "branch": "mozilla-central", 15:57:22 INFO - "script_repo_revision": "production", 15:57:22 INFO - "revision": "b4c1ad9565ee9d00d96501c4a83083daf25c1413", 15:57:22 INFO - "slavename": "talos-linux64-ix-056", 15:57:22 INFO - "repo_path": "mozilla-central" 15:57:22 INFO - } 15:57:22 INFO - Finding installer, test and symbols from parent task. 15:57:22 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fGStnulURcq0-EYoM7jsKA'}, attempt #1 15:57:23 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fGStnulURcq0-EYoM7jsKA'}, attempt #1 15:57:23 INFO - Task dependencies: ZsNuXBl0Q92uv17nTmcSug 15:57:23 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZsNuXBl0Q92uv17nTmcSug'}, attempt #1 15:57:24 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/ZsNuXBl0Q92uv17nTmcSug/artifacts/public/build/target.tar.bz2 15:57:24 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/ZsNuXBl0Q92uv17nTmcSug/artifacts/public/build/target.test_packages.json 15:57:24 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/ZsNuXBl0Q92uv17nTmcSug/artifacts/public/build/target.crashreporter-symbols.zip 15:57:24 INFO - Running post-action listener: _resource_record_post_action 15:57:24 INFO - [mozharness: 2017-09-07 22:57:24.265132Z] Finished read-buildbot-config step (success) 15:57:24 INFO - [mozharness: 2017-09-07 22:57:24.265394Z] Running download-and-extract step. 15:57:24 INFO - Running pre-action listener: _resource_record_pre_action 15:57:24 INFO - Running main action method: download_and_extract 15:57:24 INFO - mkdir: /builds/slave/test/build/tests 15:57:24 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')]} 15:57:24 INFO - trying https://queue.taskcluster.net/v1/task/ZsNuXBl0Q92uv17nTmcSug/artifacts/public/build/target.test_packages.json 15:57:24 INFO - Downloading https://queue.taskcluster.net/v1/task/ZsNuXBl0Q92uv17nTmcSug/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 15:57:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZsNuXBl0Q92uv17nTmcSug/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 15:57:24 INFO - Downloaded 989 bytes. 15:57:24 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 15:57:24 INFO - Using the following test package requirements: 15:57:24 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 15:57:24 INFO - u'common': [u'target.common.tests.zip'], 15:57:24 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 15:57:24 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 15:57:24 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 15:57:24 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 15:57:24 INFO - u'mozbase': [u'target.common.tests.zip'], 15:57:24 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 15:57:24 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 15:57:24 INFO - u'web-platform': [u'target.common.tests.zip', 15:57:24 INFO - u'target.web-platform.tests.tar.gz'], 15:57:24 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 15:57:24 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 15:57:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZsNuXBl0Q92uv17nTmcSug/artifacts/public/build/target.common.tests.zip 15:57:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZsNuXBl0Q92uv17nTmcSug/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:57:24 INFO - Fetch https://queue.taskcluster.net/v1/task/ZsNuXBl0Q92uv17nTmcSug/artifacts/public/build/target.common.tests.zip into memory 15:57:26 INFO - Content-Length response header: 55023786 15:57:26 INFO - Bytes received: 55023786 15:57:37 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 15:57:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZsNuXBl0Q92uv17nTmcSug/artifacts/public/build/target.common.tests.zip 15:57:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZsNuXBl0Q92uv17nTmcSug/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:57:37 INFO - Fetch https://queue.taskcluster.net/v1/task/ZsNuXBl0Q92uv17nTmcSug/artifacts/public/build/target.common.tests.zip into memory 15:57:38 INFO - Content-Length response header: 55023786 15:57:38 INFO - Bytes received: 55023786 15:57:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZsNuXBl0Q92uv17nTmcSug/artifacts/public/build/target.talos.tests.zip 15:57:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZsNuXBl0Q92uv17nTmcSug/artifacts/public/build/target.talos.tests.zip'}, attempt #1 15:57:54 INFO - Fetch https://queue.taskcluster.net/v1/task/ZsNuXBl0Q92uv17nTmcSug/artifacts/public/build/target.talos.tests.zip into memory 15:57:55 INFO - Content-Length response header: 14496665 15:57:55 INFO - Bytes received: 14496665 15:57:55 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')]} 15:57:55 INFO - trying https://queue.taskcluster.net/v1/task/ZsNuXBl0Q92uv17nTmcSug/artifacts/public/build/target.tar.bz2 15:57:55 INFO - Downloading https://queue.taskcluster.net/v1/task/ZsNuXBl0Q92uv17nTmcSug/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 15:57:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZsNuXBl0Q92uv17nTmcSug/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 15:57:56 INFO - Downloaded 62837949 bytes. 15:57:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZsNuXBl0Q92uv17nTmcSug/artifacts/public/build/target.tar.bz2 15:57:56 INFO - mkdir: /builds/slave/test/properties 15:57:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:57:56 INFO - Writing to file /builds/slave/test/properties/build_url 15:57:56 INFO - Contents: 15:57:56 INFO - build_url:https://queue.taskcluster.net/v1/task/ZsNuXBl0Q92uv17nTmcSug/artifacts/public/build/target.tar.bz2 15:57:56 INFO - Running post-action listener: _resource_record_post_action 15:57:56 INFO - Running post-action listener: find_tests_for_verification 15:57:56 INFO - Running post-action listener: set_extra_try_arguments 15:57:56 INFO - [mozharness: 2017-09-07 22:57:56.502830Z] Finished download-and-extract step (success) 15:57:56 INFO - [mozharness: 2017-09-07 22:57:56.502926Z] Running populate-webroot step. 15:57:56 INFO - Running pre-action listener: _resource_record_pre_action 15:57:56 INFO - Running main action method: populate_webroot 15:57:56 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:57:56 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:57:56 INFO - 'tests': ['tresize', 15:57:56 INFO - 'tcanvasmark']}, 15:57:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:57:56 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:57:56 INFO - 'tests': ['dromaeo_css', 15:57:56 INFO - 'kraken']}, 15:57:56 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:57:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:57:56 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:57:56 INFO - 'talos_options': ['--disable-stylo'], 15:57:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:57:56 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:57:56 INFO - 'tests': ['damp', 'tps']}, 15:57:56 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:57:56 INFO - 'talos_options': ['--disable-stylo'], 15:57:56 INFO - 'tests': ['damp', 'tps']}, 15:57:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:57:56 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:57:56 INFO - 'tests': ['dromaeo_dom']}, 15:57:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 15:57:56 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:57:56 INFO - 'tests': ['basic_compositor_video', 15:57:56 INFO - 'glvideo']}, 15:57:56 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 15:57:56 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 15:57:56 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:57:56 INFO - 'talos_options': ['--disable-stylo'], 15:57:56 INFO - 'tests': ['ts_paint_webext', 15:57:56 INFO - 'tp5o_webext']}, 15:57:56 INFO - 'other-e10s': {'tests': ['a11yr', 15:57:56 INFO - 'ts_paint', 15:57:56 INFO - 'tpaint', 15:57:56 INFO - 'sessionrestore', 15:57:56 INFO - 'sessionrestore_many_windows', 15:57:56 INFO - 'sessionrestore_no_auto_restore', 15:57:56 INFO - 'tabpaint']}, 15:57:56 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:57:56 INFO - 'tests': ['a11yr', 15:57:56 INFO - 'ts_paint', 15:57:56 INFO - 'tpaint', 15:57:56 INFO - 'sessionrestore', 15:57:56 INFO - 'sessionrestore_many_windows', 15:57:56 INFO - 'sessionrestore_no_auto_restore', 15:57:56 INFO - 'tabpaint']}, 15:57:56 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 15:57:56 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 15:57:56 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:57:56 INFO - 'tests': ['bloom_basic_singleton']}, 15:57:56 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:57:56 INFO - 'tests': ['bloom_basic']}, 15:57:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:57:56 INFO - 'tsvgr_opacity', 15:57:56 INFO - 'tart', 15:57:56 INFO - 'tscrollx', 15:57:56 INFO - 'tsvg_static']}, 15:57:56 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:57:56 INFO - 'tests': ['tsvgx', 15:57:56 INFO - 'tsvgr_opacity', 15:57:56 INFO - 'tart', 15:57:56 INFO - 'tscrollx', 15:57:56 INFO - 'tsvg_static']}, 15:57:56 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:57:56 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:57:56 INFO - 'talos_options': ['--disable-stylo'], 15:57:56 INFO - 'tests': ['tp5o']}, 15:57:56 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:57:56 INFO - 'talos_options': ['--mitmproxy', 15:57:56 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:57:56 INFO - '--firstNonBlankPaint'], 15:57:56 INFO - 'tests': ['tp6_google', 15:57:56 INFO - 'tp6_youtube', 15:57:56 INFO - 'tp6_amazon', 15:57:56 INFO - 'tp6_facebook']}, 15:57:56 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:57:56 INFO - 'talos_options': ['--disable-stylo', 15:57:56 INFO - '--mitmproxy', 15:57:56 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:57:56 INFO - '--firstNonBlankPaint'], 15:57:56 INFO - 'tests': ['tp6_google', 15:57:56 INFO - 'tp6_youtube', 15:57:56 INFO - 'tp6_amazon', 15:57:56 INFO - 'tp6_facebook']}, 15:57:56 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:57:56 INFO - 'talos_options': ['--stylo-threads=1', 15:57:56 INFO - '--mitmproxy', 15:57:56 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:57:56 INFO - '--firstNonBlankPaint'], 15:57:56 INFO - 'tests': ['tp6_google', 15:57:56 INFO - 'tp6_youtube', 15:57:56 INFO - 'tp6_amazon', 15:57:56 INFO - 'tp6_facebook']}, 15:57:56 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:57:56 INFO - 'talos_options': ['--xperf_path', 15:57:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:57:56 INFO - 'tests': ['tp5n']}, 15:57:56 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:57:56 INFO - 'talos_options': ['--disable-stylo', 15:57:56 INFO - '--xperf_path', 15:57:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:57:56 INFO - 'tests': ['tp5n']}}} 15:57:56 INFO - Running post-action listener: _resource_record_post_action 15:57:56 INFO - [mozharness: 2017-09-07 22:57:56.517905Z] Finished populate-webroot step (success) 15:57:56 INFO - [mozharness: 2017-09-07 22:57:56.517994Z] Running create-virtualenv step. 15:57:56 INFO - Running pre-action listener: _resource_record_pre_action 15:57:56 INFO - Running main action method: create_virtualenv 15:57:56 INFO - Creating virtualenv /builds/slave/test/build/venv 15:57:56 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:57:56 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 15:57:56 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 15:57:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:57:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:57:57 INFO - Installing distribute.............................................................................................................................................................................................done. 15:57:57 INFO - Installing pip...............done. 15:57:57 INFO - Return code: 0 15:57:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:57:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:57:57 INFO - Reading from file tmpfile_stdout 15:57:57 INFO - Output received: 15:57:57 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 15:57:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:57:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:57:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:57:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:57:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:57:57 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 0xa361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbffa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda6090>, '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 0xda6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda0f90>, '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': '52faae308a556c440401f8e5000001e8-1504825039.36694-854300185', '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 15:57:57 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 15:57:57 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 15:57:57 INFO - Using env: {'DISPLAY': ':0', 15:57:57 INFO - 'HOME': '/home/cltbld', 15:57:57 INFO - 'LANG': 'en_US.UTF-8', 15:57:57 INFO - 'LANGUAGE': 'en_US:en', 15:57:57 INFO - 'LOGNAME': 'cltbld', 15:57:57 INFO - 'MAIL': '/var/mail/cltbld', 15:57:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:57:57 INFO - 'MOZ_NO_REMOTE': '1', 15:57:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:57:57 INFO - 'NO_EM_RESTART': '1', 15:57:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:57:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:57:57 INFO - 'PWD': '/builds/slave/test', 15:57:57 INFO - 'SHELL': '/bin/bash', 15:57:57 INFO - 'SHLVL': '1', 15:57:57 INFO - 'TERM': 'linux', 15:57:57 INFO - 'TMOUT': '86400', 15:57:57 INFO - 'USER': 'cltbld', 15:57:57 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1504825039.36694-854300185', 15:57:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:57:57 INFO - '_': '/tools/buildbot/bin/python'} 15:57:58 INFO - Ignoring indexes: http://pypi.python.org/simple/ 15:57:58 INFO - Downloading/unpacking pip>=1.5 15:57:58 INFO - Running setup.py egg_info for package pip 15:57:58 INFO - warning: no files found matching 'pip/cacert.pem' 15:57:58 INFO - warning: no files found matching '*.html' under directory 'docs' 15:57:58 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:57:58 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:57:58 INFO - Installing collected packages: pip 15:57:58 INFO - Found existing installation: pip 1.1 15:57:58 INFO - Uninstalling pip: 15:57:58 INFO - Successfully uninstalled pip 15:57:58 INFO - Running setup.py install for pip 15:57:58 INFO - warning: no files found matching 'pip/cacert.pem' 15:57:58 INFO - warning: no files found matching '*.html' under directory 'docs' 15:57:58 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:57:58 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:57:58 INFO - Installing pip script to /builds/slave/test/build/venv/bin 15:57:58 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 15:57:58 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 15:57:58 INFO - Successfully installed pip 15:57:58 INFO - Cleaning up... 15:57:58 INFO - Return code: 0 15:57:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:57:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:57:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:57:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:57:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:57:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xa361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbffa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda6090>, '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 0xda6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda0f90>, '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': '52faae308a556c440401f8e5000001e8-1504825039.36694-854300185', '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 15:57:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:57:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:57:58 INFO - Using env: {'DISPLAY': ':0', 15:57:58 INFO - 'HOME': '/home/cltbld', 15:57:58 INFO - 'LANG': 'en_US.UTF-8', 15:57:58 INFO - 'LANGUAGE': 'en_US:en', 15:57:58 INFO - 'LOGNAME': 'cltbld', 15:57:58 INFO - 'MAIL': '/var/mail/cltbld', 15:57:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:57:58 INFO - 'MOZ_NO_REMOTE': '1', 15:57:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:57:58 INFO - 'NO_EM_RESTART': '1', 15:57:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:57:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:57:58 INFO - 'PWD': '/builds/slave/test', 15:57:58 INFO - 'SHELL': '/bin/bash', 15:57:58 INFO - 'SHLVL': '1', 15:57:58 INFO - 'TERM': 'linux', 15:57:58 INFO - 'TMOUT': '86400', 15:57:58 INFO - 'USER': 'cltbld', 15:57:58 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1504825039.36694-854300185', 15:57:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:57:58 INFO - '_': '/tools/buildbot/bin/python'} 15:57:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:57:58 INFO - Downloading/unpacking psutil>=3.1.1 15:57:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:57:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:57:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:57:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:58:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:58:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:58:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:58:00 INFO - Installing collected packages: psutil 15:58:00 INFO - Running setup.py install for psutil 15:58:00 INFO - building 'psutil._psutil_linux' extension 15:58:00 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 15:58:00 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 15:58:00 INFO - building 'psutil._psutil_posix' extension 15:58:00 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 15:58:00 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 15:58:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:58:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:58:00 INFO - Successfully installed psutil 15:58:00 INFO - Cleaning up... 15:58:00 INFO - Return code: 0 15:58:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:58:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:58:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:58:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:58:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:58:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xa361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbffa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda6090>, '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 0xda6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda0f90>, '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': '52faae308a556c440401f8e5000001e8-1504825039.36694-854300185', '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 15:58:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:58:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:58:00 INFO - Using env: {'DISPLAY': ':0', 15:58:00 INFO - 'HOME': '/home/cltbld', 15:58:00 INFO - 'LANG': 'en_US.UTF-8', 15:58:00 INFO - 'LANGUAGE': 'en_US:en', 15:58:00 INFO - 'LOGNAME': 'cltbld', 15:58:00 INFO - 'MAIL': '/var/mail/cltbld', 15:58:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:58:00 INFO - 'MOZ_NO_REMOTE': '1', 15:58:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:58:00 INFO - 'NO_EM_RESTART': '1', 15:58:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:58:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:58:00 INFO - 'PWD': '/builds/slave/test', 15:58:00 INFO - 'SHELL': '/bin/bash', 15:58:00 INFO - 'SHLVL': '1', 15:58:00 INFO - 'TERM': 'linux', 15:58:00 INFO - 'TMOUT': '86400', 15:58:00 INFO - 'USER': 'cltbld', 15:58:00 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1504825039.36694-854300185', 15:58:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:58:00 INFO - '_': '/tools/buildbot/bin/python'} 15:58:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:58:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:58:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:58:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:58:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:58:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:58:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:58:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:58:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:58:02 INFO - Installing collected packages: mozsystemmonitor 15:58:02 INFO - Running setup.py install for mozsystemmonitor 15:58:02 INFO - Successfully installed mozsystemmonitor 15:58:02 INFO - Cleaning up... 15:58:02 INFO - Return code: 0 15:58:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:58:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:58:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:58:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:58:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:58:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xa361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbffa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda6090>, '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 0xda6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda0f90>, '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': '52faae308a556c440401f8e5000001e8-1504825039.36694-854300185', '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 15:58:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:58:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:58:02 INFO - Using env: {'DISPLAY': ':0', 15:58:02 INFO - 'HOME': '/home/cltbld', 15:58:02 INFO - 'LANG': 'en_US.UTF-8', 15:58:02 INFO - 'LANGUAGE': 'en_US:en', 15:58:02 INFO - 'LOGNAME': 'cltbld', 15:58:02 INFO - 'MAIL': '/var/mail/cltbld', 15:58:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:58:02 INFO - 'MOZ_NO_REMOTE': '1', 15:58:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:58:02 INFO - 'NO_EM_RESTART': '1', 15:58:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:58:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:58:02 INFO - 'PWD': '/builds/slave/test', 15:58:02 INFO - 'SHELL': '/bin/bash', 15:58:02 INFO - 'SHLVL': '1', 15:58:02 INFO - 'TERM': 'linux', 15:58:02 INFO - 'TMOUT': '86400', 15:58:02 INFO - 'USER': 'cltbld', 15:58:02 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1504825039.36694-854300185', 15:58:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:58:02 INFO - '_': '/tools/buildbot/bin/python'} 15:58:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:58:02 INFO - Downloading/unpacking jsonschema==2.5.1 15:58:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:58:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:58:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:58:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:58:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:58:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:58:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:58:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:58:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:58:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:58:03 INFO - Downloading functools32-3.2.3-2.tar.gz 15:58:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:58:03 INFO - warning: no files found matching '*.txt' 15:58:03 INFO - no previously-included directories found matching 'build' 15:58:03 INFO - no previously-included directories found matching 'dist' 15:58:03 INFO - no previously-included directories found matching '.git*' 15:58:03 INFO - Installing collected packages: jsonschema, functools32 15:58:03 INFO - Running setup.py install for functools32 15:58:03 INFO - warning: no files found matching '*.txt' 15:58:03 INFO - no previously-included directories found matching 'build' 15:58:03 INFO - no previously-included directories found matching 'dist' 15:58:03 INFO - no previously-included directories found matching '.git*' 15:58:03 INFO - Successfully installed jsonschema functools32 15:58:03 INFO - Cleaning up... 15:58:03 INFO - Return code: 0 15:58:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:58:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:58:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:58:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:58:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:58:03 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 0xa361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbffa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda6090>, '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 0xda6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda0f90>, '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': '52faae308a556c440401f8e5000001e8-1504825039.36694-854300185', '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 15:58:03 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 15:58:03 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 15:58:03 INFO - Using env: {'DISPLAY': ':0', 15:58:03 INFO - 'HOME': '/home/cltbld', 15:58:03 INFO - 'LANG': 'en_US.UTF-8', 15:58:03 INFO - 'LANGUAGE': 'en_US:en', 15:58:03 INFO - 'LOGNAME': 'cltbld', 15:58:03 INFO - 'MAIL': '/var/mail/cltbld', 15:58:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:58:03 INFO - 'MOZ_NO_REMOTE': '1', 15:58:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:58:03 INFO - 'NO_EM_RESTART': '1', 15:58:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:58:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:58:03 INFO - 'PWD': '/builds/slave/test', 15:58:03 INFO - 'SHELL': '/bin/bash', 15:58:03 INFO - 'SHLVL': '1', 15:58:03 INFO - 'TERM': 'linux', 15:58:03 INFO - 'TMOUT': '86400', 15:58:03 INFO - 'USER': 'cltbld', 15:58:03 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1504825039.36694-854300185', 15:58:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:58:03 INFO - '_': '/tools/buildbot/bin/python'} 15:58:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:58:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:58:04 INFO - Cleaning up... 15:58:04 INFO - Return code: 0 15:58:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:58:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:58:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:58:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:58:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:58:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xa361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbffa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda6090>, '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 0xda6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda0f90>, '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': '52faae308a556c440401f8e5000001e8-1504825039.36694-854300185', '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 15:58:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:58:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:58:04 INFO - Using env: {'DISPLAY': ':0', 15:58:04 INFO - 'HOME': '/home/cltbld', 15:58:04 INFO - 'LANG': 'en_US.UTF-8', 15:58:04 INFO - 'LANGUAGE': 'en_US:en', 15:58:04 INFO - 'LOGNAME': 'cltbld', 15:58:04 INFO - 'MAIL': '/var/mail/cltbld', 15:58:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:58:04 INFO - 'MOZ_NO_REMOTE': '1', 15:58:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:58:04 INFO - 'NO_EM_RESTART': '1', 15:58:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:58:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:58:04 INFO - 'PWD': '/builds/slave/test', 15:58:04 INFO - 'SHELL': '/bin/bash', 15:58:04 INFO - 'SHLVL': '1', 15:58:04 INFO - 'TERM': 'linux', 15:58:04 INFO - 'TMOUT': '86400', 15:58:04 INFO - 'USER': 'cltbld', 15:58:04 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1504825039.36694-854300185', 15:58:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:58:04 INFO - '_': '/tools/buildbot/bin/python'} 15:58:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:58:04 INFO - Downloading/unpacking blobuploader==1.2.4 15:58:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:58:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:58:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:58:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:58:05 INFO - Downloading blobuploader-1.2.4.tar.gz 15:58:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:58:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:58:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:58:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:58:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:58:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:58:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:58:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:58:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:58:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:58:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:58:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:58:06 INFO - Downloading docopt-0.6.1.tar.gz 15:58:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:58:06 INFO - Installing collected packages: blobuploader, requests, docopt 15:58:06 INFO - Running setup.py install for blobuploader 15:58:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:58:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:58:06 INFO - Running setup.py install for requests 15:58:06 INFO - Running setup.py install for docopt 15:58:06 INFO - Successfully installed blobuploader requests docopt 15:58:06 INFO - Cleaning up... 15:58:06 INFO - Return code: 0 15:58:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:58:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:58:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:58:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:58:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:58:06 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 0xa361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbffa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda6090>, '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 0xda6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda0f90>, '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': '52faae308a556c440401f8e5000001e8-1504825039.36694-854300185', '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 15:58:06 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 15:58:06 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 15:58:06 INFO - Using env: {'DISPLAY': ':0', 15:58:06 INFO - 'HOME': '/home/cltbld', 15:58:06 INFO - 'LANG': 'en_US.UTF-8', 15:58:06 INFO - 'LANGUAGE': 'en_US:en', 15:58:06 INFO - 'LOGNAME': 'cltbld', 15:58:06 INFO - 'MAIL': '/var/mail/cltbld', 15:58:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:58:06 INFO - 'MOZ_NO_REMOTE': '1', 15:58:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:58:06 INFO - 'NO_EM_RESTART': '1', 15:58:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:58:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:58:06 INFO - 'PWD': '/builds/slave/test', 15:58:06 INFO - 'SHELL': '/bin/bash', 15:58:06 INFO - 'SHLVL': '1', 15:58:06 INFO - 'TERM': 'linux', 15:58:06 INFO - 'TMOUT': '86400', 15:58:06 INFO - 'USER': 'cltbld', 15:58:06 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1504825039.36694-854300185', 15:58:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:58:06 INFO - '_': '/tools/buildbot/bin/python'} 15:58:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:58:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:58:06 INFO - Running setup.py (path:/tmp/pip-Beg1iZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:58:07 INFO - Running setup.py (path:/tmp/pip-NFIAVJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:58:07 INFO - Running setup.py (path:/tmp/pip-kLe51L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:58:07 INFO - Running setup.py (path:/tmp/pip-84JvOF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:58:07 INFO - Running setup.py (path:/tmp/pip-eKDZrC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:58:07 INFO - Running setup.py (path:/tmp/pip-dSKZ6J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:58:07 INFO - Running setup.py (path:/tmp/pip-FSG85Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:58:07 INFO - Running setup.py (path:/tmp/pip-l3IbDb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:58:07 INFO - Running setup.py (path:/tmp/pip-Pi21DE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:58:07 INFO - Running setup.py (path:/tmp/pip-jO85Qu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:58:07 INFO - Running setup.py (path:/tmp/pip-qtI4vG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:58:07 INFO - Running setup.py (path:/tmp/pip-ygoLBk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:58:07 INFO - Running setup.py (path:/tmp/pip-9mblQd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:58:07 INFO - Running setup.py (path:/tmp/pip-cLFx_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:58:07 INFO - Running setup.py (path:/tmp/pip-A6jJFH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:58:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:58:08 INFO - Running setup.py (path:/tmp/pip-xKfCYl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:58:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:58:08 INFO - Running setup.py (path:/tmp/pip-Rr31Wh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:58:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:58:08 INFO - Running setup.py install for manifestparser 15:58:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:58:08 INFO - Running setup.py install for mozcrash 15:58:08 INFO - Running setup.py install for mozdebug 15:58:08 INFO - Running setup.py install for mozdevice 15:58:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:58:08 INFO - Running setup.py install for mozfile 15:58:08 INFO - Running setup.py install for mozhttpd 15:58:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:58:08 INFO - Running setup.py install for mozinfo 15:58:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:58:08 INFO - Running setup.py install for mozInstall 15:58:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:58:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:58:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:58:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:58:08 INFO - Running setup.py install for mozleak 15:58:09 INFO - Running setup.py install for mozlog 15:58:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:58:09 INFO - Running setup.py install for moznetwork 15:58:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:58:09 INFO - Running setup.py install for mozprocess 15:58:09 INFO - Running setup.py install for mozprofile 15:58:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:58:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:58:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:58:09 INFO - Running setup.py install for mozrunner 15:58:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:58:09 INFO - Running setup.py install for mozscreenshot 15:58:09 INFO - Running setup.py install for moztest 15:58:09 INFO - Running setup.py install for mozversion 15:58:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:58:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:58:09 INFO - Cleaning up... 15:58:09 INFO - Return code: 0 15:58:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:58:09 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')]} 15:58:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:58:09 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')]} 15:58:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:58:09 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 0xa361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbffa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda6090>, '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 0xda6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda0f90>, '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': '52faae308a556c440401f8e5000001e8-1504825039.36694-854300185', '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 15:58:09 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 15:58:09 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 15:58:09 INFO - Using env: {'DISPLAY': ':0', 15:58:09 INFO - 'HOME': '/home/cltbld', 15:58:09 INFO - 'LANG': 'en_US.UTF-8', 15:58:09 INFO - 'LANGUAGE': 'en_US:en', 15:58:09 INFO - 'LOGNAME': 'cltbld', 15:58:09 INFO - 'MAIL': '/var/mail/cltbld', 15:58:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:58:09 INFO - 'MOZ_NO_REMOTE': '1', 15:58:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:58:09 INFO - 'NO_EM_RESTART': '1', 15:58:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:58:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:58:09 INFO - 'PWD': '/builds/slave/test', 15:58:09 INFO - 'SHELL': '/bin/bash', 15:58:09 INFO - 'SHLVL': '1', 15:58:09 INFO - 'TERM': 'linux', 15:58:09 INFO - 'TMOUT': '86400', 15:58:09 INFO - 'USER': 'cltbld', 15:58:09 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1504825039.36694-854300185', 15:58:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:58:09 INFO - '_': '/tools/buildbot/bin/python'} 15:58:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:58:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:58:10 INFO - Running setup.py (path:/tmp/pip-zqKCGN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:58:10 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)) 15:58:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:58:10 INFO - Running setup.py (path:/tmp/pip-60MaNW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:58:10 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)) 15:58:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:58:10 INFO - Running setup.py (path:/tmp/pip-8ZdkqK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:58:10 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)) 15:58:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:58:10 INFO - Running setup.py (path:/tmp/pip-Vs0Dqn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:58:10 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)) 15:58:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:58:10 INFO - Running setup.py (path:/tmp/pip-nxsaDO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:58:10 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)) 15:58:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:58:10 INFO - Running setup.py (path:/tmp/pip-Zu9u_a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:58:10 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)) 15:58:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:58:10 INFO - Running setup.py (path:/tmp/pip-kyvd_5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:58:10 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)) 15:58:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:58:10 INFO - Running setup.py (path:/tmp/pip-gyl4hQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:58:10 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)) 15:58:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:58:10 INFO - Running setup.py (path:/tmp/pip-Hw0irG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:58:10 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)) 15:58:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:58:10 INFO - Running setup.py (path:/tmp/pip-GnGQdr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:58:10 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)) 15:58:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:58:10 INFO - Running setup.py (path:/tmp/pip-KOEBOL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:58:10 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)) 15:58:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:58:10 INFO - Running setup.py (path:/tmp/pip-_j4Rbz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:58:10 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)) 15:58:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:58:11 INFO - Running setup.py (path:/tmp/pip-nYG4Qo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:58:11 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)) 15:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:58:11 INFO - Running setup.py (path:/tmp/pip-O0N46B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:58:11 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)) 15:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:58:11 INFO - Running setup.py (path:/tmp/pip-0aZArS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:58:11 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)) 15:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:58:11 INFO - Running setup.py (path:/tmp/pip-FrL0EE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:58:11 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)) 15:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:58:11 INFO - Running setup.py (path:/tmp/pip-Uh63cD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:58:11 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)) 15:58:11 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)) 15:58:11 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)) 15:58:11 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)) 15:58:11 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)) 15:58:11 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)) 15:58:11 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)) 15:58:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:58:11 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 15:58:11 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 15:58:11 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 15:58:11 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 15:58:12 INFO - Downloading blessings-1.6.tar.gz 15:58:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:58:12 INFO - Installing collected packages: blessings 15:58:12 INFO - Running setup.py install for blessings 15:58:12 INFO - Successfully installed blessings 15:58:12 INFO - Cleaning up... 15:58:12 INFO - Return code: 0 15:58:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:58:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:58:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:58:12 INFO - Reading from file tmpfile_stdout 15:58:12 INFO - Current package versions: 15:58:12 INFO - argparse == 1.2.1 15:58:12 INFO - blessings == 1.6 15:58:12 INFO - blobuploader == 1.2.4 15:58:12 INFO - docopt == 0.6.1 15:58:12 INFO - functools32 == 3.2.3-2 15:58:12 INFO - jsonschema == 2.5.1 15:58:12 INFO - manifestparser == 1.1 15:58:12 INFO - mozInstall == 1.13 15:58:12 INFO - mozcrash == 1.0 15:58:12 INFO - mozdebug == 0.1 15:58:12 INFO - mozdevice == 0.51 15:58:12 INFO - mozfile == 1.2 15:58:12 INFO - mozhttpd == 0.7 15:58:12 INFO - mozinfo == 0.10 15:58:12 INFO - mozleak == 0.1 15:58:12 INFO - mozlog == 3.5 15:58:12 INFO - moznetwork == 0.27 15:58:12 INFO - mozprocess == 0.25 15:58:12 INFO - mozprofile == 0.28 15:58:12 INFO - mozrunner == 6.13 15:58:12 INFO - mozscreenshot == 0.1 15:58:12 INFO - mozsystemmonitor == 0.3 15:58:12 INFO - moztest == 0.8 15:58:12 INFO - mozversion == 1.4 15:58:12 INFO - psutil == 3.1.1 15:58:12 INFO - requests == 1.2.3 15:58:12 INFO - wsgiref == 0.1.2 15:58:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:58:12 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')]} 15:58:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:58:12 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')]} 15:58:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:58:12 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 0xa361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbffa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda6090>, '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 0xda6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda0f90>, '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': '52faae308a556c440401f8e5000001e8-1504825039.36694-854300185', '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 15:58:12 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 15:58:12 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 15:58:12 INFO - Using env: {'DISPLAY': ':0', 15:58:12 INFO - 'HOME': '/home/cltbld', 15:58:12 INFO - 'LANG': 'en_US.UTF-8', 15:58:12 INFO - 'LANGUAGE': 'en_US:en', 15:58:12 INFO - 'LOGNAME': 'cltbld', 15:58:12 INFO - 'MAIL': '/var/mail/cltbld', 15:58:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:58:12 INFO - 'MOZ_NO_REMOTE': '1', 15:58:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:58:12 INFO - 'NO_EM_RESTART': '1', 15:58:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:58:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:58:12 INFO - 'PWD': '/builds/slave/test', 15:58:12 INFO - 'SHELL': '/bin/bash', 15:58:12 INFO - 'SHLVL': '1', 15:58:12 INFO - 'TERM': 'linux', 15:58:12 INFO - 'TMOUT': '86400', 15:58:12 INFO - 'USER': 'cltbld', 15:58:12 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1504825039.36694-854300185', 15:58:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:58:12 INFO - '_': '/tools/buildbot/bin/python'} 15:58:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:58:13 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)) 15:58:13 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)) 15:58:13 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)) 15:58:13 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)) 15:58:13 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)) 15:58:13 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)) 15:58:13 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)) 15:58:13 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)) 15:58:13 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)) 15:58:13 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 15:58:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:58:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:58:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:58:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:58:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 15:58:14 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)) 15:58:14 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)) 15:58:14 INFO - Installing collected packages: simplejson 15:58:14 INFO - Running setup.py install for simplejson 15:58:14 INFO - building 'simplejson._speedups' extension 15:58:14 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 15:58:15 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 15:58:15 INFO - Successfully installed simplejson 15:58:15 INFO - Cleaning up... 15:58:15 INFO - Return code: 0 15:58:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:58: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')]} 15:58:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:58: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')]} 15:58:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:58:15 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 0xa361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbffa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda6090>, '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 0xda6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda0f90>, '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': '52faae308a556c440401f8e5000001e8-1504825039.36694-854300185', '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 15:58:15 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 15:58:15 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 15:58:15 INFO - Using env: {'DISPLAY': ':0', 15:58:15 INFO - 'HOME': '/home/cltbld', 15:58:15 INFO - 'LANG': 'en_US.UTF-8', 15:58:15 INFO - 'LANGUAGE': 'en_US:en', 15:58:15 INFO - 'LOGNAME': 'cltbld', 15:58:15 INFO - 'MAIL': '/var/mail/cltbld', 15:58:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:58:15 INFO - 'MOZ_NO_REMOTE': '1', 15:58:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:58:15 INFO - 'NO_EM_RESTART': '1', 15:58:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:58:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:58:15 INFO - 'PWD': '/builds/slave/test', 15:58:15 INFO - 'SHELL': '/bin/bash', 15:58:15 INFO - 'SHLVL': '1', 15:58:15 INFO - 'TERM': 'linux', 15:58:15 INFO - 'TMOUT': '86400', 15:58:15 INFO - 'USER': 'cltbld', 15:58:15 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1504825039.36694-854300185', 15:58:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:58:15 INFO - '_': '/tools/buildbot/bin/python'} 15:58:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:58:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:58:15 INFO - Cleaning up... 15:58:15 INFO - Return code: 0 15:58:15 INFO - Running post-action listener: _resource_record_post_action 15:58:15 INFO - Running post-action listener: _start_resource_monitoring 15:58:15 INFO - Starting resource monitoring. 15:58:15 INFO - [mozharness: 2017-09-07 22:58:15.614760Z] Finished create-virtualenv step (success) 15:58:15 INFO - [mozharness: 2017-09-07 22:58:15.615216Z] Running install step. 15:58:15 INFO - Running pre-action listener: _resource_record_pre_action 15:58:15 INFO - Running main action method: install 15:58:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:58:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:58:15 INFO - Reading from file tmpfile_stdout 15:58:15 INFO - Detecting whether we're running mozinstall >=1.0... 15:58:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:58:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:58:15 INFO - Reading from file tmpfile_stdout 15:58:15 INFO - Output received: 15:58:15 INFO - Usage: mozinstall [options] installer 15:58:15 INFO - Options: 15:58:15 INFO - -h, --help show this help message and exit 15:58:15 INFO - -d DEST, --destination=DEST 15:58:15 INFO - Directory to install application into. [default: 15:58:15 INFO - "/builds/slave/test"] 15:58:15 INFO - --app=APP Application being installed. [default: firefox] 15:58:15 INFO - mkdir: /builds/slave/test/build/application 15:58:15 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'] 15:58:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 15:58:32 INFO - Reading from file tmpfile_stdout 15:58:32 INFO - Output received: 15:58:32 INFO - /builds/slave/test/build/application/firefox/firefox 15:58:32 INFO - Running post-action listener: _resource_record_post_action 15:58:32 INFO - [mozharness: 2017-09-07 22:58:32.591406Z] Finished install step (success) 15:58:32 INFO - [mozharness: 2017-09-07 22:58:32.591659Z] Running setup-mitmproxy step. 15:58:32 INFO - Running pre-action listener: _resource_record_pre_action 15:58:32 INFO - Running main action method: setup_mitmproxy 15:58:32 INFO - Skipping: mitmproxy is not required 15:58:32 INFO - Running post-action listener: _resource_record_post_action 15:58:32 INFO - [mozharness: 2017-09-07 22:58:32.592799Z] Finished setup-mitmproxy step (success) 15:58:32 INFO - [mozharness: 2017-09-07 22:58:32.593018Z] Running run-tests step. 15:58:32 INFO - Running pre-action listener: _resource_record_pre_action 15:58:32 INFO - Running pre-action listener: _set_gcov_prefix 15:58:32 INFO - Running main action method: run_tests 15:58:32 WARNING - Try message not found. 15:58:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:58:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:58:32 INFO - Python 2.7.3 15:58:32 INFO - Return code: 0 15:58:32 INFO - grabbing minidump binary from tooltool 15:58:32 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')]} 15:58:32 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 0xda6090>, '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 0xda6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda0f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:58:32 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 15:58:32 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 15:58:32 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 15:58:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:58:32 INFO - Return code: 0 15:58:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:58:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:58:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:58:32 INFO - ENV: RUST_BACKTRACE is now full 15:58:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:58:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:58:32 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/ZsNuXBl0Q92uv17nTmcSug/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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 15:58:32 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/ZsNuXBl0Q92uv17nTmcSug/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-056 --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 15:58:32 INFO - Using env: {'DISPLAY': ':0', 15:58:32 INFO - 'HOME': '/home/cltbld', 15:58:32 INFO - 'LANG': 'en_US.UTF-8', 15:58:32 INFO - 'LANGUAGE': 'en_US:en', 15:58:32 INFO - 'LOGNAME': 'cltbld', 15:58:32 INFO - 'MAIL': '/var/mail/cltbld', 15:58:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:58:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:58:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:58:32 INFO - 'MOZ_NO_REMOTE': '1', 15:58:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:58:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:58:32 INFO - 'NO_EM_RESTART': '1', 15:58:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:58:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:58:32 INFO - 'PWD': '/builds/slave/test', 15:58:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:58:32 INFO - 'RUST_BACKTRACE': 'full', 15:58:32 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:58:32 INFO - 'SHELL': '/bin/bash', 15:58:32 INFO - 'SHLVL': '1', 15:58:32 INFO - 'STYLO_FORCE_ENABLED': '1', 15:58:32 INFO - 'STYLO_THREADS': '1', 15:58:32 INFO - 'TERM': 'linux', 15:58:32 INFO - 'TMOUT': '86400', 15:58:32 INFO - 'USER': 'cltbld', 15:58:32 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1504825039.36694-854300185', 15:58:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:58:32 INFO - '_': '/tools/buildbot/bin/python'} 15:58:32 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/ZsNuXBl0Q92uv17nTmcSug/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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 15:58:32 INFO - mozversion application_buildid: 20170907220040 15:58:32 INFO - mozversion application_changeset: b4c1ad9565ee9d00d96501c4a83083daf25c1413 15:58:32 INFO - mozversion application_display_name: Nightly 15:58:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:58:32 INFO - mozversion application_name: Firefox 15:58:32 INFO - mozversion application_remotingname: firefox 15:58:32 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:58:32 INFO - mozversion application_vendor: Mozilla 15:58:32 INFO - mozversion application_version: 57.0a1 15:58:32 INFO - mozversion platform_buildid: 20170907220040 15:58:32 INFO - mozversion platform_changeset: b4c1ad9565ee9d00d96501c4a83083daf25c1413 15:58:32 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:58:32 INFO - mozversion platform_version: 57.0a1 15:58:32 INFO - using testdate: 1504825112 15:58:32 INFO - actual date: 1504825112 15:58:32 INFO - starting webserver on 'localhost:36533' 15:58:32 INFO - SUITE-START | Running 2 tests 15:58:32 INFO - TEST-START | dromaeo_css 15:58:32 INFO - Initialising browser for dromaeo_css test... 15:58:32 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:36533/getInfo.html -profile /tmp/tmp_eQ4aj/profile 15:58:32 INFO - TEST-INFO | started process 14755 (/builds/slave/test/build/application/firefox/firefox http://localhost:36533/getInfo.html) 15:58:39 INFO - TEST-INFO | 14755: exit 0 15:58:39 INFO - Browser initialized. 15:58:39 INFO - Running cycle 1/1 for dromaeo_css test... 15:58:39 INFO - Using env: {'DISPLAY': ':0', 15:58:39 INFO - 'HOME': '/home/cltbld', 15:58:39 INFO - 'JSGC_DISABLE_POISONING': '1', 15:58:39 INFO - 'LANG': 'en_US.UTF-8', 15:58:39 INFO - 'LANGUAGE': 'en_US:en', 15:58:39 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 15:58:39 INFO - 'LOGNAME': 'cltbld', 15:58:39 INFO - 'MAIL': '/var/mail/cltbld', 15:58:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:58:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:58:39 INFO - 'MOZ_CRASHREPORTER': '1', 15:58:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:58:39 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 15:58:39 INFO - 'MOZ_NO_REMOTE': '1', 15:58:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:58:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:58:39 INFO - 'NO_EM_RESTART': '1', 15:58:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:58:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:58:39 INFO - 'PWD': '/builds/slave/test', 15:58:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:58:39 INFO - 'RUST_BACKTRACE': 'full', 15:58:39 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:58:39 INFO - 'SHELL': '/bin/bash', 15:58:39 INFO - 'SHLVL': '1', 15:58:39 INFO - 'STYLO_FORCE_ENABLED': '1', 15:58:39 INFO - 'STYLO_THREADS': '1', 15:58:39 INFO - 'TERM': 'linux', 15:58:39 INFO - 'TMOUT': '86400', 15:58:39 INFO - 'USER': 'cltbld', 15:58:39 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1504825039.36694-854300185', 15:58:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:58:39 INFO - '_': '/tools/buildbot/bin/python'} 15:58:39 INFO - TEST-INFO | started process 14939 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_eQ4aj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:58:40 INFO - PID 14939 | 15:58:40 INFO - PID 14939 | (/builds/slave/test/build/application/firefox/firefox:14990): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:58:40 INFO - PID 14939 | 15:58:50 INFO - PID 14939 | RSS: Main: 170799104 15:58:50 INFO - PID 14939 | 16:01:46 INFO - PID 14939 | Cycle 1(1): loaded http://localhost:36533/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36533/tests/dromaeo/cssquery-ext.html) 16:01:48 INFO - PID 14939 | RSS: Main: 174071808 16:01:48 INFO - PID 14939 | 16:04:49 INFO - PID 14939 | Cycle 1(1): loaded http://localhost:36533/tests/dromaeo/cssquery-ext.html (next: http://localhost:36533/tests/dromaeo/cssquery-jquery.html) 16:04:50 INFO - PID 14939 | RSS: Main: 170295296 16:04:50 INFO - PID 14939 | 16:07:52 INFO - PID 14939 | Cycle 1(1): loaded http://localhost:36533/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36533/tests/dromaeo/cssquery-mootools.html) 16:07:52 INFO - PID 14939 | RSS: Main: 172769280 16:07:52 INFO - PID 14939 | 16:10:54 INFO - PID 14939 | Cycle 1(1): loaded http://localhost:36533/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36533/tests/dromaeo/cssquery-prototype.html) 16:10:55 INFO - PID 14939 | RSS: Main: 169820160 16:10:55 INFO - PID 14939 | 16:13:58 INFO - PID 14939 | Cycle 1(1): loaded http://localhost:36533/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36533/tests/dromaeo/cssquery-yui.html) 16:13:59 INFO - PID 14939 | RSS: Main: 171307008 16:13:59 INFO - PID 14939 | 16:17:00 INFO - PID 14939 | Cycle 1(1): loaded http://localhost:36533/tests/dromaeo/cssquery-yui.html (next: http://localhost:36533/tests/dromaeo/cssquery-dojo.html) 16:17:01 INFO - PID 14939 | RSS: Main: 175349760 16:17:01 INFO - PID 14939 | 16:17:01 INFO - PID 14939 | __start_tp_report 16:17:01 INFO - PID 14939 | _x_x_mozilla_page_load 16:17:01 INFO - PID 14939 | _x_x_mozilla_page_load_details 16:17:01 INFO - PID 14939 | |i|pagename|runs| 16:17:01 INFO - PID 14939 | |0;dojo.html;3061.311204978879;3088.2896933705247;3125.9687403125963;3126.327839514504;3130.8591113399893;6001.48987336077;6068.453839154481;6120.357362476942;6141.508679305651;6205.906911396332;6062.363451837548;6084.117802918585;6114.908276375858;6117.2659280886355;6158.414950579688;5664.291963504572;5695;5731.512821410185;5761.971190144043;5797.913031304533;5717.028105222123;5808.82573522795;5820.650760954335;5827.708614569276;5858.88282234355;5775.971120144393;5830.533557315404;5873.70631468427;5873.8825223495505;5893.58744887858;233.98551594446417;5287.154055351125;5673.716314184274;5690.5447564194765;5792.9420705793245;5626.521745651625;5673.574481913832;5701.059325211335;5701.2018317435595;5762.567807414419;6040.275166979991;6122.357152499013;6168.506519478431;6193.938060619381;6217.253929528486;6550.737970481175;6555.278919318871;6621.801345959629;6647.135872336614;6660.4671626270265;6672.699728512229;6683.398494135503;6699.899501507482;6764.222114456851;6802.863942721167;5998.880022399528;6096.055111457731;6153.815385538441;6199.101130336076;6241.375862413768;6738;6740.460763139035;6744.156980377453;6829.3170682931805;6831.077804496329;6370.140031095742;6439.130717353191;6458.967705161444;6462.870742585122;6564.737410503526;6593.208814942238;6602.867942641216;6606.933930660728;6635.535512514078;6699.162604674416;6569.605823650596;6625.602463852184;6650.3682150195655;6651.534392592472;6651.900221496681;6644.900326495106;6658.933410665928;6673;6677.1319728435965;6717.958716398966;5220.347456567929;5305.1776974569;5311.282976798083;5328.440513746001;5333.146696528537;4514.413126293561;4562.452505699337;4564.680472366969;4602.677812553089;4619.706482184926;5828.271466066742;5844.94155058444;5848.970755146197;5849.327327357409;5867.325257595346;6644.202695676549;6661.700223489955;6738.427233685094;6759.831004224934;6759.966200168968;5804.4195580442465;5814.273215848019;5876.265466816648;5878.882422351529;5880.676562789087;5657.038303488417;5722.313322401338;5731.570132240098;5732.226149469769;5735.1970724098655;6414.294427612959;6460.289368169498;6462.806115816533;6466.838329041718;6468.741250350027;6432.163818703539;6549.083128362128;6607.867842643216;6678.198616166092;6724.092247546519;6306.84232894163;6436.871262574628;6483.2544257411;6483.805485835433;6489.1888513935755;6513.316101809241;6545.410913017851;6603.108580341785;6640.169978752656;6648.368405001517;6675.732970681119;6676.165479315086;6686.398224159849;6782.118324617768;6789.524733268624;6248.843778905563;6307.526935479766;6321.841953951004;6398.072279519351;6415.133956915944;6314.494840412848;6328.208973878265;6328.430441260309;6332.651704156316;6392.009238568029;6164.907526387197;6216.129741836237;6303.716332765129;6346.555741098079;6372.107904893412;6400.487960963205;6454.515911306765;6454.870902582016;6514.771982980573;6534.967325163344;6120.8775824484155;6166.81499555014;6233.657148856856;6282.120503129474;6307.3377295383325 16:17:01 INFO - PID 14939 | |1;ext.html;853.1170238802839;879.8592225243963;884.6107712606453;888.1207604471571;888.5068786823315;39080;39823.402648960255;42492;42855.78572107135;42982.785086074524;39030.21939561207;39165;39306.410403843896;39353;39353;7038.964805175967;7204.351608355247;7228.710851565931;7383.926160738404;7584.355329796974;7780.8832867507035;7901.170377110407;7910.050793904711;7915.881261781078;7923.683052677886;7880.684772609117;7915.960420197891;7916.485428447161;7945.165757595456;7950.3242224411;7841.137474877759;7867.567283799389;7873.566953817538;7876.52740835546;7882.921170788276;7736.7292144774665;7802.960985195038;7848.13670496245;7852.136265010844;7856.882146767803;38143.80928095342;38239.617603823885;38331.80834095839;38444.23111537754;38642.22715545702;3429;3447.0348302475345;3458.1181798641437;3464.20323325634;3467.601225859033;31328.8433557833;31481;31522.684773152203;31564;31633.52549711756;4989.625778066623;5135.691858488465;5155.742212889378;5193.428722840485;5231.293775340357;185572;186279;188344;188516.99999999863;189749;42214.366784498256;42975.35536966948;48074.75962620234;48259;48775.780605485146;51664.48335516672;51852.22221666678;52119.47880521146;52462.213066804026;52586;15921.363145474283;15943.521694349189;15995.440159594358;16167.757483637755;16210.75683864743;12966.740665186644;13007.349632518337;13028.739425211443;13037.934810325887;13088.672783180305;14053.85946140546;14071.648208794863;14130.929345353208;14169.079009864327;14181.290935453186;5633.774649014075;5665.490105890407;5757.883113573815;5884.47039766423;5913.645181289136;993.7267251505893;1009.1271050541376;1012.7417508535424;1022.3559157730582;1033.850091736709;22835.657465138036;22883.88558057199;22918.885405573197;22939.885300573726;23050.193243236405;1117.9105671546256;1121.0751130317522;1122.2144498850837;1123;1131.5982826096617;11930.463129159209;12096.274223546616;12122.212056216318;12144.332061736513;12387.256764593973;222469;223725;223889;224016;226289;53006.469935300156;53136.468635313926;53377.46622533725;53485.1977220342;53618.46381536213;1386.5909556680804;1429.992850035764;1453.1716921354725;1467.0610809082195;1467.2956980649135;22137.003834827792;22364.664530032387;22733.204337848096;23003.539929200986;23121.421964451023;37866.242675146896;37938.24123517459;38024.80987595155;38040.619593803705;38087.238255235294;190123;190957;191268;191738;192120;33596.83201583976;35140.472892907135;36636;36728.26543469169;36802.26395472022;47142;47157;47438;47682.761586191846;47683.28475072946;33543.49684754682;33878;34001;34067.65932340744;34072;33070.33859322752;33491.49762753512;33572.83213583916;33662;34405.82797085999;36926.44610330901;38160.618393815705;38476.615233848424;38535;38805.41791873068;32898.50652240266;33422.665773341956;33638.663613363555;33660.158496037795;33794.15514612154;24276.51446971086;24452;24553.140640077512;24734.876325618257;25058.37354066163 16:17:01 INFO - PID 14939 | |2;jquery.html;573.9081746920491;573.9942600573993;574.7068994812646;578.1443463673766;584.8888711144883;21838.344849654495;22604;22634.320970370914;22635;22721.431964200863;23150.65274020891;23980.28059158228;24248.27255182343;24283.635745463787;24284.63573046406;5889.528837692985;6567.080608714784;6644.867102657944;6653.401193892549;6653.900191497131;6358.395952384516;6602.603843769365;6659.067730517731;6716.731330746764;6725.495587830907;6577.704003319838;6585.506087043467;6586.341365863424;6590.34096590342;6600.075989361493;6590.340965903395;6592.406683398493;6598.538102332838;6598.769043083493;6625.271220165778;5876.823695289148;6133.877322453526;6134.754609815602;6137.938620613826;6150.784722534735;28011.87952481898;28564.857175713987;28641.28396790076;28703.42593148125;28737.856310718522;1977.821996020365;1997.3109277299309;1998.1607724755638;1998.3505360757667;2005.7392538969987;19240.134193961305;19508.902455487772;19842.801571984382;19882.900585497126;19934.601307973906;2427.0655797517907;2438.853668779861;2478.4175718706088;2478.5042991401792;2484.850908945451;115608;119402.40298798538;127164;133756;133951.99999999904;14131.576052718436;14337.35481903317;14483;14653.34059967304;14704.411823527153;22045.228417005328;22059.889700551714;22061.558768824532;22178.1128754848;22286.442838929157;9763.755906102404;9817.607295708234;9921.305508614329;9997.200223982063;10009.849852252222;8922.375433719577;8970.641174352953;9063.365564410427;9107.134822192014;9265.44407335562;8990.55047247635;9185.540722963826;9207.90792092084;9301.395409298373;9305.53472326381;2701.8243814152015;2717.5244332241778;2719.551274039761;2725.7001729809704;2815.5635876439183;960.9039096090335;986.3243678080538;986.5215370545279;989.351974456732;994.4729293474326;18354.08229588542;18749.25002999892;18820.247190112517;18951.90524047371;19376.4187074388;1034.8758149022165;1045.4981608827804;1046.7069220618087;1052.5263631365915;1056.963006294776;10392.324498907547;10481.161507079416;10506.369617822955;10826.458677066115;10915.727106822234;447751;460942;462214;465485;487281;105501.47249263858;105574.83275501747;105635;106510.46744766382;106857.46571267249;1072.8015317166194;1191.7676053169548;1194.832723418722;1197.976040479203;1198.9700257493457;16386.18069096564;16968.32126714967;17293;17334.73997890058;17407.47777566675;51715.70710732262;53285.7335713319;53372.73313633407;54497.455025449235;54765.452345476035;64019;64724.35275647183;64825.35174648193;65936.67031664812;68150;13999.370028348545;14315.284235788376;14344.56966291013;14364.784528231876;14399.136051836504;22078.33764987053;22236.88881555582;22306.330810075724;22324;22421.215257465912;16863.662726745642;16943;17052.232649530553;17111.14444277806;17564.121793910508;15940.8405915944;16028.11845348517;16122.516324510283;16326.510204693877;16359.34562617482;18092.81907180964;18101.637967240316;18152.90923545374;18252.45242642723;18633.254669813057;13840.238786866415;13863.792043119563;14010.299485025911;14017.439302427789;14038.78941815853;17491.38780142689;17579.208935598184;17842.19710113022;17894.373696920546;18014.36949706754 16:17:01 INFO - PID 14939 | |3;mootools.html;1312.9080964332497;1370.808086867838;1393.8536453672357;1395.1559306619502;1398.1541167593602;14930.701385972288;14951.102933823951;15423.768643470357;15551.844481555181;15620.218989050545;15509.302081406335;15926.52220433386;15928.362865485367;15928.442504512344;15993.600159996005;2687.48937701837;2728.5361488546996;2742.6708794944534;2750.2986738381683;2751.862406879658;2623.095032213893;2723.577845433961;2775.528160212769;2780.3466185446405;2792.860356982153;2724.196362073193;2725.6320396746482;2752.0367871245103;2753.0501976817964;2758.586212068186;2693.3535951371728;2696.487667343208;2708.9593656095176;2711.986440067797;2732.699403065661;2547.783438407738;2549.8980040798533;2558.8336758110663;2561.1164148368784;2574.1633968960164;14531.128132312095;14855.702885942328;14878.553643390716;14885.330160142712;14890.776638350433;7037.612931288777;7331.193568707438;7336.082989626297;7374.188839227681;7388.815279617998;5128.2564028216075;5194.870128246824;5211.452797456288;5236.633435659505;5236.973815130938;1867.215769376865;1923.8460923126117;1960.5196726801883;1987.1951859496926;2025.605007023631;26028.86985565079;26126.477470450485;26175;26241.3439664008;26330.341741456617;6623.503237257129;6840.589564626139;7111.040009598638;7153.105861767279;7190.9280907191305;17225.827741722424;17256.913715431343;17371.305147793948;17399.304027838996;17423.73864392035;7215.170255420694;7698;7834.059912810385;8179.386546009073;8218.958905205436;7204.783856484314;7208.315210055036;7234.312740289664;7257.8911316330295;7259.963700181465;5104.591632669378;5217.2695822584865;5220.817271395483;5247.632665713363;5261.394939581921;1464.6411629150925;1466.933987970544;1468.0824484697064;1484.3246322923044;1485.2722166138515;859.5100792548187;887.6981826179131;901.4996676844414;904.6924045824451;907.5915837872851;7392.371648409838;7419.77239900645;7437.925620743831;7511.624418779039;7590.962045189739;700.1633048507088;700.537645154206;707.3209718670134;713.3330336135626;721.8339781850204;4631.397918270603;4806;4841.540053694894;5047.394312682502;5191;20802.791972080387;21308.680369794467;21652.025658845076;22154.113835446402;22301;21794.78205217959;21971.121155153935;22069.33791986243;22097.55804883893;22166.445838853837;10610.946945265225;11463.31220126795;11582.71043223926;11646.475908584134;11701.063914886618;7801.414893882868;7928.207179282256;7957.602119893866;7989.440739148204;8019.358451323997;18050.729239061162;18505.53736156607;18527.907360463112;18954.52613684669;18964.620707585495;19301.80698193;19304.613907721487;19343.51641208981;19492.512687182367;19602.215911363386;11056.447177640925;11143.164262680493;11148.888511114785;11155.609553665583;11163.330200188015;13604.93197534006;13881.37533811001;13957;14085.718285634435;14095.577132686036;11351.545938162712;11438.656840294805;11511.07911367072;11631.59289424866;11853.288802671867;10488;10549.841752373874;10676.199285053497;10742.89257107419;10939.50772215268;9251.306152038489;9310.162085412345;9376.718698439057;9430.481323527272;9503.097205765442;6853.143357080365;6908.171019477695;6982.615956122462;6990.231074581894;7013.859722805618;6909.378155965987;6980.7207711693;7004.474664400293;7056.7530136444975;7153.964230178815 16:17:01 INFO - PID 14939 | |4;prototype.html;498.8121173884325;501.47094814970194;511.0009930585701;523.7302789063633;526.3026489900882;6017.4885134763545;6059.272887253535;6116.571839971192;6163.414475624814;6239.656818874966;6042.667653279079;6073.757049718006;6098.39016098391;6098.603590766597;6125.142480052785;5105.18317069269;5129.589362925198;5149.253358263049;5187.83273763404;5223.112070947929;4761.952380476203;5095.79616815327;5135.691858488484;5153.845384638467;5207.802205492739;4790.616750659956;4841.426536375674;4884.6824956377895;4906.582940450066;4915.5084491550915;4899.632527560448;4920.138975679278;4933.407991041062;4938.7406211415855;4966.975165124188;4302.311630139194;4355.390245365651;4377.846775362847;4390.8902277443;4414.227510185705;6001.129836173774;6071.1803906472505;6116.593183567805;6130.570860039799;6137.386261373871;5614.606977511576;5640.351359593658;5652.682400215892;5654.575906806965;5663.830085097454;6379.521535884827;6436.485081193493;6461.12774775404;6462.773802916875;6510.609363438209;4715.39272456571;4739.336492890998;4766.642501812344;4780.402449693788;4781.760911954389;6729.192496900403;6803.829904252384;6830.282820303896;6918.965405172992;6966.656005117521;4903.705777653352;4919.87700307488;4972.776225069808;4981.551660350586;4991.825286114969;5053.242013697901;5055.6713813602;5057.393112826411;5079.949200508022;5085.821996230115;5560.637643777301;5581.386047534768;5670.5463562914865;5691.548655093007;5723.084306510938;6397.776077837347;6464.515161362917;6493.123428337209;6513.41379275858;6567.802965910934;1666.7249903765985;1735.9132043397778;1741.2077504735314;1752.3078384038233;1759.4985429152887;1146.2492067695673;1194.8028575285155;1214.4717048084112;1230.1634888276058;1241.74544218435;5698.601097923189;5700.971495142498;5721.427857214246;5776.826695199151;5788.102844059177;6502.187226596676;6548.934510654928;6579.374959378852;6638.336166383323;6659.800205993828;5668.319801623831;5721.599488035798;5723.627964182315;5821.097729851795;5851.444112809277;3505.3339865425487;3519.348920449725;3574.6067932527403;3595.532580764484;3598.2623562169692;6425.935740642627;6466.741330346734;6534.281229064799;6546.312637173123;6554.246261679872;6881.587104773729;6917.273686262971;6951.617661028591;6981.860362792716;6984.930150698428;6499.025146228104;6519.934800652028;6526.193736693267;6570.605763654196;6599.241087275025;6597.538172327891;6633.436157926437;6671.397445379441;6710.731570737311;6738.2924792898;6653.37191809223;6654.534182607171;6660.533762636569;6670.232923213893;6723.697433615401;6519;6572.178477690289;6618.128394889044;6628.403443690091;6655.534112612071;4958.851234462972;4961.677490963076;4988.55103040728;5015.623828212826;5024.171011783015;6731.427828634621;6770.559913605797;6799.966000169968;6802.6258555779905;6848.246692863681;6464;6480;6505;6534.444572211415;6625.801225963229;6377.17096777416;6436.774712885027;6459.160309159779;6486.643234621953;6534.242810384143;6084.817455476343;6218.502519798315;6247.3440288769025;6271.43557079865;6306.432421082125;5928.733207005609;6479.773207937888;6500.479961602966;6506.479481641552;6573.5069869759;6222.782202622887;6242.656653883898;6256.1857061451665;6261.78083767066;6300.149479820166 16:17:01 INFO - PID 14939 | |5;yui.html;906.6871929184432;913.5751875377948;929.8372784762665;931.2456909902979;942.1708896171368;18320.541986450327;18866.43400697978;18877.05614719262;18898.14958326875;18932.62134757304;17508;17924.283028678838;18339.724904126448;18403.53991150222;18493.81506184938;942.3074040580185;950.6007476859701;951.6907005223295;953.5041778275292;953.7281874665722;978.4667356290838;978.6134476881628;987.0376383026563;987.0968064221229;987.4223579206138;997.5959736306771;1030.1655658916263;1042.3745752548487;1042.8852826189113;1042.968710938673;1009.1321463541349;1023.2121266624695;1024.4109636958779;1025.374521541859;1025.9589616415335;734.7428400059989;754.728297812787;759.5632511306021;762.2073044034198;763.969441222356;20449.89775051115;20478.385648430572;20539.281125160698;20598.38204853857;20619;21758.456038599004;21793.128274868985;22349.106035758712;22476.32571022872;22500.43748906274;17718.291268349378;17786;17879.195436205402;17902.28390864364;17979.640407191913;3740.532433445819;3757.6242375762204;3777.8299976501125;3781.3760729479604;3786.450964610116;109107;144661;147490;147918.99999999892;149911;17033.31866725317;17798;17826.10869456522;17844;17851.196696148443;31422.68577314243;32159.678403216138;32272.35455290881;32279.51580726291;32295.838520807247;8619.82760344802;8821.558922053871;9067.773305667411;9088.409253398508;9093.545322733837;4303.956960430356;4372.6939114261695;4382.167388196232;4394.450693663292;4396.3625274335045;5108.361454818148;5170.043541944752;5234.319538460052;5249.897521520447;5250.684958902478;1051.353417648141;1051.7791263834526;1066.248294952057;1075.9784804304027;1081.043276700126;679.1917618034622;687.556526040701;703.7994171661052;705.816487713188;712.8253577873351;10904.182186336056;11174.608888688857;11220.887791121984;11276.492557834918;11309.943450282695;607.0772425912676;623.9812805615838;637.1239545624766;641.9582727122722;645.6190847400056;5174.922376164285;5184.870378240575;5256.342957130359;5328.893422131536;5345.492178243061;124009.37995309966;124724;127304;130012;131848;103610;104020;106876.46561767296;108733.45633271783;116323.41838290755;91809.54095229482;93100.53449732844;96258;100674;100934.49532752289;11177.776444471228;11589.362585057903;11640.825387619023;12220.40588493293;12417.006639469002;42552;44726;45169;45182.77408612936;45540.544594553634;56577.151342730715;56686.7165664169;56722;57153.42846571481;57683.7115814435;16335.509934701979;16683.165841707625;16847.663046739242;16855.1572421376;16881.32474700998;16741.74887376715;16787.412440564523;16824.158792060593;16825;16877.071761052768;15808.209589520708;15978.520644380687;16027;16121.274542645375;16140.354385824436;15668.68662626764;15718.764218536502;15749.763753543477;15904.76142857835;15941;13515.526956556474;13563.186208827501;13580.728385432434;13593.86406135926;13629.659258518617;10069;10112.342697724624;10118.94940525322;10131.442770647685;10138.898611013796;12503.499860005863;12549.623511294676;12662.176958498037;12693.238405695687;12806.615801525597 16:17:01 INFO - PID 14939 | __end_tp_report 16:17:01 INFO - PID 14939 | __start_cc_report 16:17:01 INFO - PID 14939 | _x_x_mozilla_cycle_collect,370 16:17:01 INFO - PID 14939 | __end_cc_report 16:17:01 INFO - PID 14939 | __startTimestamp1504826221008__endTimestamp 16:17:01 INFO - PID 14939 | 16:17:01 INFO - PID 14939 | ------- Summary: start ------- 16:17:01 INFO - PID 14939 | Number of tests: 6 16:17:01 INFO - PID 14939 | 16:17:01 INFO - PID 14939 | [#0] dojo.html Cycles:165 Average:6066.02 Median:6303.72 stddev:850.54 (13.5%) stddev-sans-first:819.84 16:17:01 INFO - PID 14939 | Values: 3061.3 3088.3 3126.0 3126.3 3130.9 6001.5 6068.5 6120.4 6141.5 6205.9 6062.4 6084.1 6114.9 6117.3 6158.4 5664.3 5695.0 5731.5 5762.0 5797.9 5717.0 5808.8 5820.7 5827.7 5858.9 5776.0 5830.5 5873.7 5873.9 5893.6 234.0 5287.2 5673.7 5690.5 5792.9 5626.5 5673.6 5701.1 5701.2 5762.6 6040.3 6122.4 6168.5 6193.9 6217.3 6550.7 6555.3 6621.8 6647.1 6660.5 6672.7 6683.4 6699.9 6764.2 6802.9 5998.9 6096.1 6153.8 6199.1 6241.4 6738.0 6740.5 6744.2 6829.3 6831.1 6370.1 6439.1 6459.0 6462.9 6564.7 6593.2 6602.9 6606.9 6635.5 6699.2 6569.6 6625.6 6650.4 6651.5 6651.9 6644.9 6658.9 6673.0 6677.1 6718.0 5220.3 5305.2 5311.3 5328.4 5333.1 4514.4 4562.5 4564.7 4602.7 4619.7 5828.3 5844.9 5849.0 5849.3 5867.3 6644.2 6661.7 6738.4 6759.8 6760.0 5804.4 5814.3 5876.3 5878.9 5880.7 5657.0 5722.3 5731.6 5732.2 5735.2 6414.3 6460.3 6462.8 6466.8 6468.7 6432.2 6549.1 6607.9 6678.2 6724.1 6306.8 6436.9 6483.3 6483.8 6489.2 6513.3 6545.4 6603.1 6640.2 6648.4 6675.7 6676.2 6686.4 6782.1 6789.5 6248.8 6307.5 6321.8 6398.1 6415.1 6314.5 6328.2 6328.4 6332.7 6392.0 6164.9 6216.1 6303.7 6346.6 6372.1 6400.5 6454.5 6454.9 6514.8 6535.0 6120.9 6166.8 6233.7 6282.1 6307.3 16:17:01 INFO - PID 14939 | 16:17:01 INFO - PID 14939 | [#1] ext.html Cycles:180 Average:37462.41 Median:35888.24 stddev:52198.15 (145.4%) stddev-sans-first:52272.20 16:17:01 INFO - PID 14939 | Values: 853.1 879.9 884.6 888.1 888.5 39080.0 39823.4 42492.0 42855.8 42982.8 39030.2 39165.0 39306.4 39353.0 39353.0 7039.0 7204.4 7228.7 7383.9 7584.4 7780.9 7901.2 7910.1 7915.9 7923.7 7880.7 7916.0 7916.5 7945.2 7950.3 7841.1 7867.6 7873.6 7876.5 7882.9 7736.7 7803.0 7848.1 7852.1 7856.9 38143.8 38239.6 38331.8 38444.2 38642.2 3429.0 3447.0 3458.1 3464.2 3467.6 31328.8 31481.0 31522.7 31564.0 31633.5 4989.6 5135.7 5155.7 5193.4 5231.3 185572.0 186279.0 188344.0 188517.0 189749.0 42214.4 42975.4 48074.8 48259.0 48775.8 51664.5 51852.2 52119.5 52462.2 52586.0 15921.4 15943.5 15995.4 16167.8 16210.8 12966.7 13007.3 13028.7 13037.9 13088.7 14053.9 14071.6 14130.9 14169.1 14181.3 5633.8 5665.5 5757.9 5884.5 5913.6 993.7 1009.1 1012.7 1022.4 1033.9 22835.7 22883.9 22918.9 22939.9 23050.2 1117.9 1121.1 1122.2 1123.0 1131.6 11930.5 12096.3 12122.2 12144.3 12387.3 222469.0 223725.0 223889.0 224016.0 226289.0 53006.5 53136.5 53377.5 53485.2 53618.5 1386.6 1430.0 1453.2 1467.1 1467.3 22137.0 22364.7 22733.2 23003.5 23121.4 37866.2 37938.2 38024.8 38040.6 38087.2 190123.0 190957.0 191268.0 191738.0 192120.0 33596.8 35140.5 36636.0 36728.3 36802.3 47142.0 47157.0 47438.0 47682.8 47683.3 33543.5 33878.0 34001.0 34067.7 34072.0 33070.3 33491.5 33572.8 33662.0 34405.8 36926.4 38160.6 38476.6 38535.0 38805.4 32898.5 33422.7 33638.7 33660.2 33794.2 24276.5 24452.0 24553.1 24734.9 25058.4 16:17:01 INFO - PID 14939 | 16:17:01 INFO - PID 14939 | [#2] jquery.html Cycles:180 Average:32914.16 Median:22372.61 stddev:77999.53 (348.6%) stddev-sans-first:78180.54 16:17:01 INFO - PID 14939 | Values: 573.9 574.0 574.7 578.1 584.9 21838.3 22604.0 22634.3 22635.0 22721.4 23150.7 23980.3 24248.3 24283.6 24284.6 5889.5 6567.1 6644.9 6653.4 6653.9 6358.4 6602.6 6659.1 6716.7 6725.5 6577.7 6585.5 6586.3 6590.3 6600.1 6590.3 6592.4 6598.5 6598.8 6625.3 5876.8 6133.9 6134.8 6137.9 6150.8 28011.9 28564.9 28641.3 28703.4 28737.9 1977.8 1997.3 1998.2 1998.4 2005.7 19240.1 19508.9 19842.8 19882.9 19934.6 2427.1 2438.9 2478.4 2478.5 2484.9 115608.0 119402.4 127164.0 133756.0 133952.0 14131.6 14337.4 14483.0 14653.3 14704.4 22045.2 22059.9 22061.6 22178.1 22286.4 9763.8 9817.6 9921.3 9997.2 10009.8 8922.4 8970.6 9063.4 9107.1 9265.4 8990.6 9185.5 9207.9 9301.4 9305.5 2701.8 2717.5 2719.6 2725.7 2815.6 960.9 986.3 986.5 989.4 994.5 18354.1 18749.3 18820.2 18951.9 19376.4 1034.9 1045.5 1046.7 1052.5 1057.0 10392.3 10481.2 10506.4 10826.5 10915.7 447751.0 460942.0 462214.0 465485.0 487281.0 105501.5 105574.8 105635.0 106510.5 106857.5 1072.8 1191.8 1194.8 1198.0 1199.0 16386.2 16968.3 17293.0 17334.7 17407.5 51715.7 53285.7 53372.7 54497.5 54765.5 64019.0 64724.4 64825.4 65936.7 68150.0 13999.4 14315.3 14344.6 14364.8 14399.1 22078.3 22236.9 22306.3 22324.0 22421.2 16863.7 16943.0 17052.2 17111.1 17564.1 15940.8 16028.1 16122.5 16326.5 16359.3 18092.8 18101.6 18152.9 18252.5 18633.3 13840.2 13863.8 14010.3 14017.4 14038.8 17491.4 17579.2 17842.2 17894.4 18014.4 16:17:01 INFO - PID 14939 | 16:17:01 INFO - PID 14939 | [#3] mootools.html Cycles:180 Average:9253.85 Median:14508.92 stddev:6735.43 (46.4%) stddev-sans-first:6727.90 16:17:01 INFO - PID 14939 | Values: 1312.9 1370.8 1393.9 1395.2 1398.2 14930.7 14951.1 15423.8 15551.8 15620.2 15509.3 15926.5 15928.4 15928.4 15993.6 2687.5 2728.5 2742.7 2750.3 2751.9 2623.1 2723.6 2775.5 2780.3 2792.9 2724.2 2725.6 2752.0 2753.1 2758.6 2693.4 2696.5 2709.0 2712.0 2732.7 2547.8 2549.9 2558.8 2561.1 2574.2 14531.1 14855.7 14878.6 14885.3 14890.8 7037.6 7331.2 7336.1 7374.2 7388.8 5128.3 5194.9 5211.5 5236.6 5237.0 1867.2 1923.8 1960.5 1987.2 2025.6 26028.9 26126.5 26175.0 26241.3 26330.3 6623.5 6840.6 7111.0 7153.1 7190.9 17225.8 17256.9 17371.3 17399.3 17423.7 7215.2 7698.0 7834.1 8179.4 8219.0 7204.8 7208.3 7234.3 7257.9 7260.0 5104.6 5217.3 5220.8 5247.6 5261.4 1464.6 1466.9 1468.1 1484.3 1485.3 859.5 887.7 901.5 904.7 907.6 7392.4 7419.8 7437.9 7511.6 7591.0 700.2 700.5 707.3 713.3 721.8 4631.4 4806.0 4841.5 5047.4 5191.0 20802.8 21308.7 21652.0 22154.1 22301.0 21794.8 21971.1 22069.3 22097.6 22166.4 10610.9 11463.3 11582.7 11646.5 11701.1 7801.4 7928.2 7957.6 7989.4 8019.4 18050.7 18505.5 18527.9 18954.5 18964.6 19301.8 19304.6 19343.5 19492.5 19602.2 11056.4 11143.2 11148.9 11155.6 11163.3 13604.9 13881.4 13957.0 14085.7 14095.6 11351.5 11438.7 11511.1 11631.6 11853.3 10488.0 10549.8 10676.2 10742.9 10939.5 9251.3 9310.2 9376.7 9430.5 9503.1 6853.1 6908.2 6982.6 6990.2 7013.9 6909.4 6980.7 7004.5 7056.8 7154.0 16:17:01 INFO - PID 14939 | 16:17:01 INFO - PID 14939 | [#4] prototype.html Cycles:180 Average:5478.14 Median:6072.47 stddev:1539.27 (25.3%) stddev-sans-first:1497.53 16:17:01 INFO - PID 14939 | Values: 498.8 501.5 511.0 523.7 526.3 6017.5 6059.3 6116.6 6163.4 6239.7 6042.7 6073.8 6098.4 6098.6 6125.1 5105.2 5129.6 5149.3 5187.8 5223.1 4762.0 5095.8 5135.7 5153.8 5207.8 4790.6 4841.4 4884.7 4906.6 4915.5 4899.6 4920.1 4933.4 4938.7 4967.0 4302.3 4355.4 4377.8 4390.9 4414.2 6001.1 6071.2 6116.6 6130.6 6137.4 5614.6 5640.4 5652.7 5654.6 5663.8 6379.5 6436.5 6461.1 6462.8 6510.6 4715.4 4739.3 4766.6 4780.4 4781.8 6729.2 6803.8 6830.3 6919.0 6966.7 4903.7 4919.9 4972.8 4981.6 4991.8 5053.2 5055.7 5057.4 5079.9 5085.8 5560.6 5581.4 5670.5 5691.5 5723.1 6397.8 6464.5 6493.1 6513.4 6567.8 1666.7 1735.9 1741.2 1752.3 1759.5 1146.2 1194.8 1214.5 1230.2 1241.7 5698.6 5701.0 5721.4 5776.8 5788.1 6502.2 6548.9 6579.4 6638.3 6659.8 5668.3 5721.6 5723.6 5821.1 5851.4 3505.3 3519.3 3574.6 3595.5 3598.3 6425.9 6466.7 6534.3 6546.3 6554.2 6881.6 6917.3 6951.6 6981.9 6984.9 6499.0 6519.9 6526.2 6570.6 6599.2 6597.5 6633.4 6671.4 6710.7 6738.3 6653.4 6654.5 6660.5 6670.2 6723.7 6519.0 6572.2 6618.1 6628.4 6655.5 4958.9 4961.7 4988.6 5015.6 5024.2 6731.4 6770.6 6800.0 6802.6 6848.2 6464.0 6480.0 6505.0 6534.4 6625.8 6377.2 6436.8 6459.2 6486.6 6534.2 6084.8 6218.5 6247.3 6271.4 6306.4 5928.7 6479.8 6500.5 6506.5 6573.5 6222.8 6242.7 6256.2 6261.8 6300.1 16:17:01 INFO - PID 14939 | 16:17:01 INFO - PID 14939 | [#5] yui.html Cycles:180 Average:24471.13 Median:18448.68 stddev:35833.14 (194.2%) stddev-sans-first:35889.97 16:17:01 INFO - PID 14939 | Values: 906.7 913.6 929.8 931.2 942.2 18320.5 18866.4 18877.1 18898.1 18932.6 17508.0 17924.3 18339.7 18403.5 18493.8 942.3 950.6 951.7 953.5 953.7 978.5 978.6 987.0 987.1 987.4 997.6 1030.2 1042.4 1042.9 1043.0 1009.1 1023.2 1024.4 1025.4 1026.0 734.7 754.7 759.6 762.2 764.0 20449.9 20478.4 20539.3 20598.4 20619.0 21758.5 21793.1 22349.1 22476.3 22500.4 17718.3 17786.0 17879.2 17902.3 17979.6 3740.5 3757.6 3777.8 3781.4 3786.5 109107.0 144661.0 147490.0 147919.0 149911.0 17033.3 17798.0 17826.1 17844.0 17851.2 31422.7 32159.7 32272.4 32279.5 32295.8 8619.8 8821.6 9067.8 9088.4 9093.5 4304.0 4372.7 4382.2 4394.5 4396.4 5108.4 5170.0 5234.3 5249.9 5250.7 1051.4 1051.8 1066.2 1076.0 1081.0 679.2 687.6 703.8 705.8 712.8 10904.2 11174.6 11220.9 11276.5 11309.9 607.1 624.0 637.1 642.0 645.6 5174.9 5184.9 5256.3 5328.9 5345.5 124009.4 124724.0 127304.0 130012.0 131848.0 103610.0 104020.0 106876.5 108733.5 116323.4 91809.5 93100.5 96258.0 100674.0 100934.5 11177.8 11589.4 11640.8 12220.4 12417.0 42552.0 44726.0 45169.0 45182.8 45540.5 56577.2 56686.7 56722.0 57153.4 57683.7 16335.5 16683.2 16847.7 16855.2 16881.3 16741.7 16787.4 16824.2 16825.0 16877.1 15808.2 15978.5 16027.0 16121.3 16140.4 15668.7 15718.8 15749.8 15904.8 15941.0 13515.5 13563.2 13580.7 13593.9 13629.7 10069.0 10112.3 10118.9 10131.4 10138.9 12503.5 12549.6 12662.2 12693.2 12806.6 16:17:01 INFO - PID 14939 | -------- Summary: end -------- 16:17:01 INFO - PID 14939 | 16:17:01 INFO - TEST-INFO | 14939: exit 0 16:17:01 INFO - TEST-OK | dromaeo_css | took 1108876ms 16:17:01 INFO - TEST-START | kraken 16:17:01 INFO - Initialising browser for kraken test... 16:17:01 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:36533/getInfo.html -profile /tmp/tmp81Mm4I/profile 16:17:01 INFO - TEST-INFO | started process 15320 (/builds/slave/test/build/application/firefox/firefox http://localhost:36533/getInfo.html) 16:17:07 INFO - TEST-INFO | 15320: exit 0 16:17:07 INFO - Browser initialized. 16:17:07 INFO - Running cycle 1/1 for kraken test... 16:17:07 INFO - Using env: {'DISPLAY': ':0', 16:17:07 INFO - 'HOME': '/home/cltbld', 16:17:07 INFO - 'JSGC_DISABLE_POISONING': '1', 16:17:07 INFO - 'LANG': 'en_US.UTF-8', 16:17:07 INFO - 'LANGUAGE': 'en_US:en', 16:17:07 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 16:17:07 INFO - 'LOGNAME': 'cltbld', 16:17:07 INFO - 'MAIL': '/var/mail/cltbld', 16:17:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:17:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:17:07 INFO - 'MOZ_CRASHREPORTER': '1', 16:17:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:17:07 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 16:17:07 INFO - 'MOZ_NO_REMOTE': '1', 16:17:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:17:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:17:07 INFO - 'NO_EM_RESTART': '1', 16:17:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:17:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:17:07 INFO - 'PWD': '/builds/slave/test', 16:17:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:17:07 INFO - 'RUST_BACKTRACE': 'full', 16:17:07 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:17:07 INFO - 'SHELL': '/bin/bash', 16:17:07 INFO - 'SHLVL': '1', 16:17:07 INFO - 'STYLO_FORCE_ENABLED': '1', 16:17:07 INFO - 'STYLO_THREADS': '1', 16:17:07 INFO - 'TERM': 'linux', 16:17:07 INFO - 'TMOUT': '86400', 16:17:07 INFO - 'USER': 'cltbld', 16:17:07 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1504825039.36694-854300185', 16:17:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:17:07 INFO - '_': '/tools/buildbot/bin/python'} 16:17:07 INFO - TEST-INFO | started process 15510 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp81Mm4I/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:17:08 INFO - PID 15510 | 16:17:08 INFO - PID 15510 | (/builds/slave/test/build/application/firefox/firefox:15561): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:17:08 INFO - PID 15510 | 16:17:19 INFO - PID 15510 | RSS: Main: 169943040 16:17:19 INFO - PID 15510 | 16:17:21 INFO - PID 15510 | Cycle 1(1): loaded http://localhost:36533/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36533/tests/kraken/driver.html?testName=audio-beat-detection) 16:17:22 INFO - PID 15510 | RSS: Main: 175943680 16:17:22 INFO - PID 15510 | 16:17:25 INFO - PID 15510 | Cycle 1(1): loaded http://localhost:36533/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36533/tests/kraken/driver.html?testName=audio-dft) 16:17:26 INFO - PID 15510 | RSS: Main: 176480256 16:17:26 INFO - PID 15510 | 16:17:29 INFO - PID 15510 | Cycle 1(1): loaded http://localhost:36533/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36533/tests/kraken/driver.html?testName=audio-fft) 16:17:29 INFO - PID 15510 | RSS: Main: 171388928 16:17:29 INFO - PID 15510 | 16:17:31 INFO - PID 15510 | Cycle 1(1): loaded http://localhost:36533/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36533/tests/kraken/driver.html?testName=audio-oscillator) 16:17:32 INFO - PID 15510 | RSS: Main: 172191744 16:17:32 INFO - PID 15510 | 16:17:34 INFO - PID 15510 | Cycle 1(1): loaded http://localhost:36533/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36533/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:17:35 INFO - PID 15510 | RSS: Main: 172371968 16:17:35 INFO - PID 15510 | 16:17:38 INFO - PID 15510 | Cycle 1(1): loaded http://localhost:36533/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36533/tests/kraken/driver.html?testName=imaging-darkroom) 16:17:39 INFO - PID 15510 | RSS: Main: 174981120 16:17:39 INFO - PID 15510 | 16:17:42 INFO - PID 15510 | Cycle 1(1): loaded http://localhost:36533/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36533/tests/kraken/driver.html?testName=imaging-desaturate) 16:17:43 INFO - PID 15510 | RSS: Main: 174673920 16:17:43 INFO - PID 15510 | 16:17:46 INFO - PID 15510 | Cycle 1(1): loaded http://localhost:36533/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36533/tests/kraken/driver.html?testName=json-parse-financial) 16:17:46 INFO - PID 15510 | RSS: Main: 175013888 16:17:46 INFO - PID 15510 | 16:17:48 INFO - PID 15510 | Cycle 1(1): loaded http://localhost:36533/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36533/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:17:49 INFO - PID 15510 | RSS: Main: 174948352 16:17:49 INFO - PID 15510 | 16:17:50 INFO - PID 15510 | Cycle 1(1): loaded http://localhost:36533/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36533/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:17:51 INFO - PID 15510 | RSS: Main: 172113920 16:17:51 INFO - PID 15510 | 16:17:53 INFO - PID 15510 | Cycle 1(1): loaded http://localhost:36533/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36533/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:17:54 INFO - PID 15510 | RSS: Main: 172146688 16:17:54 INFO - PID 15510 | 16:17:56 INFO - PID 15510 | Cycle 1(1): loaded http://localhost:36533/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36533/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:17:57 INFO - PID 15510 | RSS: Main: 173166592 16:17:57 INFO - PID 15510 | 16:18:00 INFO - PID 15510 | Cycle 1(1): loaded http://localhost:36533/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36533/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:18:01 INFO - PID 15510 | RSS: Main: 172883968 16:18:01 INFO - PID 15510 | 16:18:02 INFO - PID 15510 | Cycle 1(1): loaded http://localhost:36533/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36533/tests/kraken/driver.html?testName=ai-astar) 16:18:03 INFO - PID 15510 | RSS: Main: 174755840 16:18:03 INFO - PID 15510 | 16:18:03 INFO - PID 15510 | __start_tp_report 16:18:03 INFO - PID 15510 | _x_x_mozilla_page_load 16:18:03 INFO - PID 15510 | _x_x_mozilla_page_load_details 16:18:03 INFO - PID 15510 | |i|pagename|runs| 16:18:03 INFO - PID 15510 | |0;ai-astar;110;110;109;108;107;109;116;97;108;110 16:18:03 INFO - PID 15510 | |1;audio-beat-detection;120;115;115;117;120;116;117;119;129;120 16:18:03 INFO - PID 15510 | |2;audio-dft;165;163;164;166;165;163;173;167;163;165 16:18:03 INFO - PID 15510 | |3;audio-fft;75;73;74;76;73;74;76;75;75;75 16:18:03 INFO - PID 15510 | |4;audio-oscillator;80;80;79;79;78;79;78;78;78;80 16:18:03 INFO - PID 15510 | |5;imaging-gaussian-blur;114;114;114;114;114;114;115;115;115;115 16:18:03 INFO - PID 15510 | |6;imaging-darkroom;149;148;149;148;149;147;148;151;149;152 16:18:03 INFO - PID 15510 | |7;imaging-desaturate;95;95;94;94;94;96;94;97;94;94 16:18:03 INFO - PID 15510 | |8;json-parse-financial;55;52;64;56;55;52;53;53;51;49 16:18:03 INFO - PID 15510 | |9;json-stringify-tinderbox;38;38;38;38;38;38;38;38;39;39 16:18:03 INFO - PID 15510 | |10;stanford-crypto-aes;75;74;75;75;79;86;76;77;76;76 16:18:03 INFO - PID 15510 | |11;stanford-crypto-ccm;125;128;121;124;117;141;119;128;120;120 16:18:03 INFO - PID 15510 | |12;stanford-crypto-pbkdf2;180;181;166;176;168;170;167;174;169;172 16:18:03 INFO - PID 15510 | |13;stanford-crypto-sha256-iterative;66;69;66;71;67;66;65;66;64;65 16:18:03 INFO - PID 15510 | __end_tp_report 16:18:03 INFO - PID 15510 | __start_cc_report 16:18:03 INFO - PID 15510 | _x_x_mozilla_cycle_collect,942 16:18:03 INFO - PID 15510 | __end_cc_report 16:18:03 INFO - PID 15510 | __startTimestamp1504826283107__endTimestamp 16:18:03 INFO - PID 15510 | 16:18:03 INFO - PID 15510 | ------- Summary: start ------- 16:18:03 INFO - PID 15510 | Number of tests: 14 16:18:03 INFO - PID 15510 | 16:18:03 INFO - PID 15510 | [#0] ai-astar Cycles:10 Average:108.40 Median:110.00 stddev:4.70 (4.3%) stddev-sans-first:4.94 16:18:03 INFO - PID 15510 | Values: 110.0 110.0 109.0 108.0 107.0 109.0 116.0 97.0 108.0 110.0 16:18:03 INFO - PID 15510 | 16:18:03 INFO - PID 15510 | [#1] audio-beat-detection Cycles:10 Average:118.80 Median:119.50 stddev:4.10 (3.4%) stddev-sans-first:4.33 16:18:03 INFO - PID 15510 | Values: 120.0 115.0 115.0 117.0 120.0 116.0 117.0 119.0 129.0 120.0 16:18:03 INFO - PID 15510 | 16:18:03 INFO - PID 15510 | [#2] audio-dft Cycles:10 Average:165.40 Median:165.00 stddev:2.99 (1.8%) stddev-sans-first:3.17 16:18:03 INFO - PID 15510 | Values: 165.0 163.0 164.0 166.0 165.0 163.0 173.0 167.0 163.0 165.0 16:18:03 INFO - PID 15510 | 16:18:03 INFO - PID 15510 | [#3] audio-fft Cycles:10 Average:74.60 Median:75.00 stddev:1.07 (1.4%) stddev-sans-first:1.13 16:18:03 INFO - PID 15510 | Values: 75.0 73.0 74.0 76.0 73.0 74.0 76.0 75.0 75.0 75.0 16:18:03 INFO - PID 15510 | 16:18:03 INFO - PID 15510 | [#4] audio-oscillator Cycles:10 Average:78.90 Median:79.00 stddev:0.88 (1.1%) stddev-sans-first:0.83 16:18:03 INFO - PID 15510 | Values: 80.0 80.0 79.0 79.0 78.0 79.0 78.0 78.0 78.0 80.0 16:18:03 INFO - PID 15510 | 16:18:03 INFO - PID 15510 | [#5] imaging-gaussian-blur Cycles:10 Average:114.40 Median:114.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 16:18:03 INFO - PID 15510 | Values: 114.0 114.0 114.0 114.0 114.0 114.0 115.0 115.0 115.0 115.0 16:18:03 INFO - PID 15510 | 16:18:03 INFO - PID 15510 | [#6] imaging-darkroom Cycles:10 Average:149.00 Median:149.00 stddev:1.49 (1.0%) stddev-sans-first:1.58 16:18:03 INFO - PID 15510 | Values: 149.0 148.0 149.0 148.0 149.0 147.0 148.0 151.0 149.0 152.0 16:18:03 INFO - PID 15510 | 16:18:03 INFO - PID 15510 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:94.50 stddev:1.06 (1.1%) stddev-sans-first:1.12 16:18:03 INFO - PID 15510 | Values: 95.0 95.0 94.0 94.0 94.0 96.0 94.0 97.0 94.0 94.0 16:18:03 INFO - PID 15510 | 16:18:03 INFO - PID 15510 | [#8] json-parse-financial Cycles:10 Average:54.00 Median:54.00 stddev:4.08 (7.6%) stddev-sans-first:4.31 16:18:03 INFO - PID 15510 | Values: 55.0 52.0 64.0 56.0 55.0 52.0 53.0 53.0 51.0 49.0 16:18:03 INFO - PID 15510 | 16:18:03 INFO - PID 15510 | [#9] json-stringify-tinderbox Cycles:10 Average:38.20 Median:38.00 stddev:0.42 (1.1%) stddev-sans-first:0.44 16:18:03 INFO - PID 15510 | Values: 38.0 38.0 38.0 38.0 38.0 38.0 38.0 38.0 39.0 39.0 16:18:03 INFO - PID 15510 | 16:18:03 INFO - PID 15510 | [#10] stanford-crypto-aes Cycles:10 Average:76.90 Median:76.00 stddev:3.48 (4.6%) stddev-sans-first:3.62 16:18:03 INFO - PID 15510 | Values: 75.0 74.0 75.0 75.0 79.0 86.0 76.0 77.0 76.0 76.0 16:18:03 INFO - PID 15510 | 16:18:03 INFO - PID 15510 | [#11] stanford-crypto-ccm Cycles:10 Average:124.30 Median:124.50 stddev:6.96 (5.6%) stddev-sans-first:7.38 16:18:03 INFO - PID 15510 | Values: 125.0 128.0 121.0 124.0 117.0 141.0 119.0 128.0 120.0 120.0 16:18:03 INFO - PID 15510 | 16:18:03 INFO - PID 15510 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.30 Median:173.00 stddev:5.31 (3.1%) stddev-sans-first:4.85 16:18:03 INFO - PID 15510 | Values: 180.0 181.0 166.0 176.0 168.0 170.0 167.0 174.0 169.0 172.0 16:18:03 INFO - PID 15510 | 16:18:03 INFO - PID 15510 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:66.00 stddev:2.07 (3.1%) stddev-sans-first:2.19 16:18:03 INFO - PID 15510 | Values: 66.0 69.0 66.0 71.0 67.0 66.0 65.0 66.0 64.0 65.0 16:18:03 INFO - PID 15510 | -------- Summary: end -------- 16:18:03 INFO - PID 15510 | 16:18:03 INFO - PID 15510 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 16:18:03 INFO - TEST-INFO | 15510: exit 0 16:18:03 INFO - TEST-OK | kraken | took 62016ms 16:18:03 INFO - SUITE-END | took 1170s 16:18:04 INFO - Completed test suite (00:19:31) 16:18:04 INFO - javascript benchmark 16:18:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8412.803993521291, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3061.311204978879, 3088.2896933705247, 3125.9687403125963, 3126.327839514504, 3130.8591113399893, 6001.48987336077, 6068.453839154481, 6120.357362476942, 6141.508679305651, 6205.906911396332, 6062.363451837548, 6084.117802918585, 6114.908276375858, 6117.2659280886355, 6158.414950579688, 5664.291963504572, 5695.0, 5731.512821410185, 5761.971190144043, 5797.913031304533, 5717.028105222123, 5808.82573522795, 5820.650760954335, 5827.708614569276, 5858.88282234355, 5775.971120144393, 5830.533557315404, 5873.70631468427, 5873.8825223495505, 5893.58744887858, 233.98551594446417, 5287.154055351125, 5673.716314184274, 5690.5447564194765, 5792.9420705793245, 5626.521745651625, 5673.574481913832, 5701.059325211335, 5701.2018317435595, 5762.567807414419, 6040.275166979991, 6122.357152499013, 6168.506519478431, 6193.938060619381, 6217.253929528486, 6550.737970481175, 6555.278919318871, 6621.801345959629, 6647.135872336614, 6660.4671626270265, 6672.699728512229, 6683.398494135503, 6699.899501507482, 6764.222114456851, 6802.863942721167, 5998.880022399528, 6096.055111457731, 6153.815385538441, 6199.101130336076, 6241.375862413768, 6738.0, 6740.460763139035, 6744.156980377453, 6829.3170682931805, 6831.077804496329, 6370.140031095742, 6439.130717353191, 6458.967705161444, 6462.870742585122, 6564.737410503526, 6593.208814942238, 6602.867942641216, 6606.933930660728, 6635.535512514078, 6699.162604674416, 6569.605823650596, 6625.602463852184, 6650.3682150195655, 6651.534392592472, 6651.900221496681, 6644.900326495106, 6658.933410665928, 6673.0, 6677.1319728435965, 6717.958716398966, 5220.347456567929, 5305.1776974569, 5311.282976798083, 5328.440513746001, 5333.146696528537, 4514.413126293561, 4562.452505699337, 4564.680472366969, 4602.677812553089, 4619.706482184926, 5828.271466066742, 5844.94155058444, 5848.970755146197, 5849.327327357409, 5867.325257595346, 6644.202695676549, 6661.700223489955, 6738.427233685094, 6759.831004224934, 6759.966200168968, 5804.4195580442465, 5814.273215848019, 5876.265466816648, 5878.882422351529, 5880.676562789087, 5657.038303488417, 5722.313322401338, 5731.570132240098, 5732.226149469769, 5735.1970724098655, 6414.294427612959, 6460.289368169498, 6462.806115816533, 6466.838329041718, 6468.741250350027, 6432.163818703539, 6549.083128362128, 6607.867842643216, 6678.198616166092, 6724.092247546519, 6306.84232894163, 6436.871262574628, 6483.2544257411, 6483.805485835433, 6489.1888513935755, 6513.316101809241, 6545.410913017851, 6603.108580341785, 6640.169978752656, 6648.368405001517, 6675.732970681119, 6676.165479315086, 6686.398224159849, 6782.118324617768, 6789.524733268624, 6248.843778905563, 6307.526935479766, 6321.841953951004, 6398.072279519351, 6415.133956915944, 6314.494840412848, 6328.208973878265, 6328.430441260309, 6332.651704156316, 6392.009238568029, 6164.907526387197, 6216.129741836237, 6303.716332765129, 6346.555741098079, 6372.107904893412, 6400.487960963205, 6454.515911306765, 6454.870902582016, 6514.771982980573, 6534.967325163344, 6120.8775824484155, 6166.81499555014, 6233.657148856856, 6282.120503129474, 6307.3377295383325], "value": 6005.57954914022, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [853.1170238802839, 879.8592225243963, 884.6107712606453, 888.1207604471571, 888.5068786823315, 39080.0, 39823.402648960255, 42492.0, 42855.78572107135, 42982.785086074524, 39030.21939561207, 39165.0, 39306.410403843896, 39353.0, 39353.0, 7038.964805175967, 7204.351608355247, 7228.710851565931, 7383.926160738404, 7584.355329796974, 7780.8832867507035, 7901.170377110407, 7910.050793904711, 7915.881261781078, 7923.683052677886, 7880.684772609117, 7915.960420197891, 7916.485428447161, 7945.165757595456, 7950.3242224411, 7841.137474877759, 7867.567283799389, 7873.566953817538, 7876.52740835546, 7882.921170788276, 7736.7292144774665, 7802.960985195038, 7848.13670496245, 7852.136265010844, 7856.882146767803, 38143.80928095342, 38239.617603823885, 38331.80834095839, 38444.23111537754, 38642.22715545702, 3429.0, 3447.0348302475345, 3458.1181798641437, 3464.20323325634, 3467.601225859033, 31328.8433557833, 31481.0, 31522.684773152203, 31564.0, 31633.52549711756, 4989.625778066623, 5135.691858488465, 5155.742212889378, 5193.428722840485, 5231.293775340357, 185572.0, 186279.0, 188344.0, 188516.99999999863, 189749.0, 42214.366784498256, 42975.35536966948, 48074.75962620234, 48259.0, 48775.780605485146, 51664.48335516672, 51852.22221666678, 52119.47880521146, 52462.213066804026, 52586.0, 15921.363145474283, 15943.521694349189, 15995.440159594358, 16167.757483637755, 16210.75683864743, 12966.740665186644, 13007.349632518337, 13028.739425211443, 13037.934810325887, 13088.672783180305, 14053.85946140546, 14071.648208794863, 14130.929345353208, 14169.079009864327, 14181.290935453186, 5633.774649014075, 5665.490105890407, 5757.883113573815, 5884.47039766423, 5913.645181289136, 993.7267251505893, 1009.1271050541376, 1012.7417508535424, 1022.3559157730582, 1033.850091736709, 22835.657465138036, 22883.88558057199, 22918.885405573197, 22939.885300573726, 23050.193243236405, 1117.9105671546256, 1121.0751130317522, 1122.2144498850837, 1123.0, 1131.5982826096617, 11930.463129159209, 12096.274223546616, 12122.212056216318, 12144.332061736513, 12387.256764593973, 222469.0, 223725.0, 223889.0, 224016.0, 226289.0, 53006.469935300156, 53136.468635313926, 53377.46622533725, 53485.1977220342, 53618.46381536213, 1386.5909556680804, 1429.992850035764, 1453.1716921354725, 1467.0610809082195, 1467.2956980649135, 22137.003834827792, 22364.664530032387, 22733.204337848096, 23003.539929200986, 23121.421964451023, 37866.242675146896, 37938.24123517459, 38024.80987595155, 38040.619593803705, 38087.238255235294, 190123.0, 190957.0, 191268.0, 191738.0, 192120.0, 33596.83201583976, 35140.472892907135, 36636.0, 36728.26543469169, 36802.26395472022, 47142.0, 47157.0, 47438.0, 47682.761586191846, 47683.28475072946, 33543.49684754682, 33878.0, 34001.0, 34067.65932340744, 34072.0, 33070.33859322752, 33491.49762753512, 33572.83213583916, 33662.0, 34405.82797085999, 36926.44610330901, 38160.618393815705, 38476.615233848424, 38535.0, 38805.41791873068, 32898.50652240266, 33422.665773341956, 33638.663613363555, 33660.158496037795, 33794.15514612154, 24276.51446971086, 24452.0, 24553.140640077512, 24734.876325618257, 25058.37354066163], "value": 17288.63534605492, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [573.9081746920491, 573.9942600573993, 574.7068994812646, 578.1443463673766, 584.8888711144883, 21838.344849654495, 22604.0, 22634.320970370914, 22635.0, 22721.431964200863, 23150.65274020891, 23980.28059158228, 24248.27255182343, 24283.635745463787, 24284.63573046406, 5889.528837692985, 6567.080608714784, 6644.867102657944, 6653.401193892549, 6653.900191497131, 6358.395952384516, 6602.603843769365, 6659.067730517731, 6716.731330746764, 6725.495587830907, 6577.704003319838, 6585.506087043467, 6586.341365863424, 6590.34096590342, 6600.075989361493, 6590.340965903395, 6592.406683398493, 6598.538102332838, 6598.769043083493, 6625.271220165778, 5876.823695289148, 6133.877322453526, 6134.754609815602, 6137.938620613826, 6150.784722534735, 28011.87952481898, 28564.857175713987, 28641.28396790076, 28703.42593148125, 28737.856310718522, 1977.821996020365, 1997.3109277299309, 1998.1607724755638, 1998.3505360757667, 2005.7392538969987, 19240.134193961305, 19508.902455487772, 19842.801571984382, 19882.900585497126, 19934.601307973906, 2427.0655797517907, 2438.853668779861, 2478.4175718706088, 2478.5042991401792, 2484.850908945451, 115608.0, 119402.40298798538, 127164.0, 133756.0, 133951.99999999904, 14131.576052718436, 14337.35481903317, 14483.0, 14653.34059967304, 14704.411823527153, 22045.228417005328, 22059.889700551714, 22061.558768824532, 22178.1128754848, 22286.442838929157, 9763.755906102404, 9817.607295708234, 9921.305508614329, 9997.200223982063, 10009.849852252222, 8922.375433719577, 8970.641174352953, 9063.365564410427, 9107.134822192014, 9265.44407335562, 8990.55047247635, 9185.540722963826, 9207.90792092084, 9301.395409298373, 9305.53472326381, 2701.8243814152015, 2717.5244332241778, 2719.551274039761, 2725.7001729809704, 2815.5635876439183, 960.9039096090335, 986.3243678080538, 986.5215370545279, 989.351974456732, 994.4729293474326, 18354.08229588542, 18749.25002999892, 18820.247190112517, 18951.90524047371, 19376.4187074388, 1034.8758149022165, 1045.4981608827804, 1046.7069220618087, 1052.5263631365915, 1056.963006294776, 10392.324498907547, 10481.161507079416, 10506.369617822955, 10826.458677066115, 10915.727106822234, 447751.0, 460942.0, 462214.0, 465485.0, 487281.0, 105501.47249263858, 105574.83275501747, 105635.0, 106510.46744766382, 106857.46571267249, 1072.8015317166194, 1191.7676053169548, 1194.832723418722, 1197.976040479203, 1198.9700257493457, 16386.18069096564, 16968.32126714967, 17293.0, 17334.73997890058, 17407.47777566675, 51715.70710732262, 53285.7335713319, 53372.73313633407, 54497.455025449235, 54765.452345476035, 64019.0, 64724.35275647183, 64825.35174648193, 65936.67031664812, 68150.0, 13999.370028348545, 14315.284235788376, 14344.56966291013, 14364.784528231876, 14399.136051836504, 22078.33764987053, 22236.88881555582, 22306.330810075724, 22324.0, 22421.215257465912, 16863.662726745642, 16943.0, 17052.232649530553, 17111.14444277806, 17564.121793910508, 15940.8405915944, 16028.11845348517, 16122.516324510283, 16326.510204693877, 16359.34562617482, 18092.81907180964, 18101.637967240316, 18152.90923545374, 18252.45242642723, 18633.254669813057, 13840.238786866415, 13863.792043119563, 14010.299485025911, 14017.439302427789, 14038.78941815853, 17491.38780142689, 17579.208935598184, 17842.19710113022, 17894.373696920546, 18014.36949706754], "value": 11661.299227851316, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1312.9080964332497, 1370.808086867838, 1393.8536453672357, 1395.1559306619502, 1398.1541167593602, 14930.701385972288, 14951.102933823951, 15423.768643470357, 15551.844481555181, 15620.218989050545, 15509.302081406335, 15926.52220433386, 15928.362865485367, 15928.442504512344, 15993.600159996005, 2687.48937701837, 2728.5361488546996, 2742.6708794944534, 2750.2986738381683, 2751.862406879658, 2623.095032213893, 2723.577845433961, 2775.528160212769, 2780.3466185446405, 2792.860356982153, 2724.196362073193, 2725.6320396746482, 2752.0367871245103, 2753.0501976817964, 2758.586212068186, 2693.3535951371728, 2696.487667343208, 2708.9593656095176, 2711.986440067797, 2732.699403065661, 2547.783438407738, 2549.8980040798533, 2558.8336758110663, 2561.1164148368784, 2574.1633968960164, 14531.128132312095, 14855.702885942328, 14878.553643390716, 14885.330160142712, 14890.776638350433, 7037.612931288777, 7331.193568707438, 7336.082989626297, 7374.188839227681, 7388.815279617998, 5128.2564028216075, 5194.870128246824, 5211.452797456288, 5236.633435659505, 5236.973815130938, 1867.215769376865, 1923.8460923126117, 1960.5196726801883, 1987.1951859496926, 2025.605007023631, 26028.86985565079, 26126.477470450485, 26175.0, 26241.3439664008, 26330.341741456617, 6623.503237257129, 6840.589564626139, 7111.040009598638, 7153.105861767279, 7190.9280907191305, 17225.827741722424, 17256.913715431343, 17371.305147793948, 17399.304027838996, 17423.73864392035, 7215.170255420694, 7698.0, 7834.059912810385, 8179.386546009073, 8218.958905205436, 7204.783856484314, 7208.315210055036, 7234.312740289664, 7257.8911316330295, 7259.963700181465, 5104.591632669378, 5217.2695822584865, 5220.817271395483, 5247.632665713363, 5261.394939581921, 1464.6411629150925, 1466.933987970544, 1468.0824484697064, 1484.3246322923044, 1485.2722166138515, 859.5100792548187, 887.6981826179131, 901.4996676844414, 904.6924045824451, 907.5915837872851, 7392.371648409838, 7419.77239900645, 7437.925620743831, 7511.624418779039, 7590.962045189739, 700.1633048507088, 700.537645154206, 707.3209718670134, 713.3330336135626, 721.8339781850204, 4631.397918270603, 4806.0, 4841.540053694894, 5047.394312682502, 5191.0, 20802.791972080387, 21308.680369794467, 21652.025658845076, 22154.113835446402, 22301.0, 21794.78205217959, 21971.121155153935, 22069.33791986243, 22097.55804883893, 22166.445838853837, 10610.946945265225, 11463.31220126795, 11582.71043223926, 11646.475908584134, 11701.063914886618, 7801.414893882868, 7928.207179282256, 7957.602119893866, 7989.440739148204, 8019.358451323997, 18050.729239061162, 18505.53736156607, 18527.907360463112, 18954.52613684669, 18964.620707585495, 19301.80698193, 19304.613907721487, 19343.51641208981, 19492.512687182367, 19602.215911363386, 11056.447177640925, 11143.164262680493, 11148.888511114785, 11155.609553665583, 11163.330200188015, 13604.93197534006, 13881.37533811001, 13957.0, 14085.718285634435, 14095.577132686036, 11351.545938162712, 11438.656840294805, 11511.07911367072, 11631.59289424866, 11853.288802671867, 10488.0, 10549.841752373874, 10676.199285053497, 10742.89257107419, 10939.50772215268, 9251.306152038489, 9310.162085412345, 9376.718698439057, 9430.481323527272, 9503.097205765442, 6853.143357080365, 6908.171019477695, 6982.615956122462, 6990.231074581894, 7013.859722805618, 6909.378155965987, 6980.7207711693, 7004.474664400293, 7056.7530136444975, 7153.964230178815], "value": 6538.095569735915, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [498.8121173884325, 501.47094814970194, 511.0009930585701, 523.7302789063633, 526.3026489900882, 6017.4885134763545, 6059.272887253535, 6116.571839971192, 6163.414475624814, 6239.656818874966, 6042.667653279079, 6073.757049718006, 6098.39016098391, 6098.603590766597, 6125.142480052785, 5105.18317069269, 5129.589362925198, 5149.253358263049, 5187.83273763404, 5223.112070947929, 4761.952380476203, 5095.79616815327, 5135.691858488484, 5153.845384638467, 5207.802205492739, 4790.616750659956, 4841.426536375674, 4884.6824956377895, 4906.582940450066, 4915.5084491550915, 4899.632527560448, 4920.138975679278, 4933.407991041062, 4938.7406211415855, 4966.975165124188, 4302.311630139194, 4355.390245365651, 4377.846775362847, 4390.8902277443, 4414.227510185705, 6001.129836173774, 6071.1803906472505, 6116.593183567805, 6130.570860039799, 6137.386261373871, 5614.606977511576, 5640.351359593658, 5652.682400215892, 5654.575906806965, 5663.830085097454, 6379.521535884827, 6436.485081193493, 6461.12774775404, 6462.773802916875, 6510.609363438209, 4715.39272456571, 4739.336492890998, 4766.642501812344, 4780.402449693788, 4781.760911954389, 6729.192496900403, 6803.829904252384, 6830.282820303896, 6918.965405172992, 6966.656005117521, 4903.705777653352, 4919.87700307488, 4972.776225069808, 4981.551660350586, 4991.825286114969, 5053.242013697901, 5055.6713813602, 5057.393112826411, 5079.949200508022, 5085.821996230115, 5560.637643777301, 5581.386047534768, 5670.5463562914865, 5691.548655093007, 5723.084306510938, 6397.776077837347, 6464.515161362917, 6493.123428337209, 6513.41379275858, 6567.802965910934, 1666.7249903765985, 1735.9132043397778, 1741.2077504735314, 1752.3078384038233, 1759.4985429152887, 1146.2492067695673, 1194.8028575285155, 1214.4717048084112, 1230.1634888276058, 1241.74544218435, 5698.601097923189, 5700.971495142498, 5721.427857214246, 5776.826695199151, 5788.102844059177, 6502.187226596676, 6548.934510654928, 6579.374959378852, 6638.336166383323, 6659.800205993828, 5668.319801623831, 5721.599488035798, 5723.627964182315, 5821.097729851795, 5851.444112809277, 3505.3339865425487, 3519.348920449725, 3574.6067932527403, 3595.532580764484, 3598.2623562169692, 6425.935740642627, 6466.741330346734, 6534.281229064799, 6546.312637173123, 6554.246261679872, 6881.587104773729, 6917.273686262971, 6951.617661028591, 6981.860362792716, 6984.930150698428, 6499.025146228104, 6519.934800652028, 6526.193736693267, 6570.605763654196, 6599.241087275025, 6597.538172327891, 6633.436157926437, 6671.397445379441, 6710.731570737311, 6738.2924792898, 6653.37191809223, 6654.534182607171, 6660.533762636569, 6670.232923213893, 6723.697433615401, 6519.0, 6572.178477690289, 6618.128394889044, 6628.403443690091, 6655.534112612071, 4958.851234462972, 4961.677490963076, 4988.55103040728, 5015.623828212826, 5024.171011783015, 6731.427828634621, 6770.559913605797, 6799.966000169968, 6802.6258555779905, 6848.246692863681, 6464.0, 6480.0, 6505.0, 6534.444572211415, 6625.801225963229, 6377.17096777416, 6436.774712885027, 6459.160309159779, 6486.643234621953, 6534.242810384143, 6084.817455476343, 6218.502519798315, 6247.3440288769025, 6271.43557079865, 6306.432421082125, 5928.733207005609, 6479.773207937888, 6500.479961602966, 6506.479481641552, 6573.5069869759, 6222.782202622887, 6242.656653883898, 6256.1857061451665, 6261.78083767066, 6300.149479820166], "value": 5024.719558900097, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [906.6871929184432, 913.5751875377948, 929.8372784762665, 931.2456909902979, 942.1708896171368, 18320.541986450327, 18866.43400697978, 18877.05614719262, 18898.14958326875, 18932.62134757304, 17508.0, 17924.283028678838, 18339.724904126448, 18403.53991150222, 18493.81506184938, 942.3074040580185, 950.6007476859701, 951.6907005223295, 953.5041778275292, 953.7281874665722, 978.4667356290838, 978.6134476881628, 987.0376383026563, 987.0968064221229, 987.4223579206138, 997.5959736306771, 1030.1655658916263, 1042.3745752548487, 1042.8852826189113, 1042.968710938673, 1009.1321463541349, 1023.2121266624695, 1024.4109636958779, 1025.374521541859, 1025.9589616415335, 734.7428400059989, 754.728297812787, 759.5632511306021, 762.2073044034198, 763.969441222356, 20449.89775051115, 20478.385648430572, 20539.281125160698, 20598.38204853857, 20619.0, 21758.456038599004, 21793.128274868985, 22349.106035758712, 22476.32571022872, 22500.43748906274, 17718.291268349378, 17786.0, 17879.195436205402, 17902.28390864364, 17979.640407191913, 3740.532433445819, 3757.6242375762204, 3777.8299976501125, 3781.3760729479604, 3786.450964610116, 109107.0, 144661.0, 147490.0, 147918.99999999892, 149911.0, 17033.31866725317, 17798.0, 17826.10869456522, 17844.0, 17851.196696148443, 31422.68577314243, 32159.678403216138, 32272.35455290881, 32279.51580726291, 32295.838520807247, 8619.82760344802, 8821.558922053871, 9067.773305667411, 9088.409253398508, 9093.545322733837, 4303.956960430356, 4372.6939114261695, 4382.167388196232, 4394.450693663292, 4396.3625274335045, 5108.361454818148, 5170.043541944752, 5234.319538460052, 5249.897521520447, 5250.684958902478, 1051.353417648141, 1051.7791263834526, 1066.248294952057, 1075.9784804304027, 1081.043276700126, 679.1917618034622, 687.556526040701, 703.7994171661052, 705.816487713188, 712.8253577873351, 10904.182186336056, 11174.608888688857, 11220.887791121984, 11276.492557834918, 11309.943450282695, 607.0772425912676, 623.9812805615838, 637.1239545624766, 641.9582727122722, 645.6190847400056, 5174.922376164285, 5184.870378240575, 5256.342957130359, 5328.893422131536, 5345.492178243061, 124009.37995309966, 124724.0, 127304.0, 130012.0, 131848.0, 103610.0, 104020.0, 106876.46561767296, 108733.45633271783, 116323.41838290755, 91809.54095229482, 93100.53449732844, 96258.0, 100674.0, 100934.49532752289, 11177.776444471228, 11589.362585057903, 11640.825387619023, 12220.40588493293, 12417.006639469002, 42552.0, 44726.0, 45169.0, 45182.77408612936, 45540.544594553634, 56577.151342730715, 56686.7165664169, 56722.0, 57153.42846571481, 57683.7115814435, 16335.509934701979, 16683.165841707625, 16847.663046739242, 16855.1572421376, 16881.32474700998, 16741.74887376715, 16787.412440564523, 16824.158792060593, 16825.0, 16877.071761052768, 15808.209589520708, 15978.520644380687, 16027.0, 16121.274542645375, 16140.354385824436, 15668.68662626764, 15718.764218536502, 15749.763753543477, 15904.76142857835, 15941.0, 13515.526956556474, 13563.186208827501, 13580.728385432434, 13593.86406135926, 13629.659258518617, 10069.0, 10112.342697724624, 10118.94940525322, 10131.442770647685, 10138.898611013796, 12503.499860005863, 12549.623511294676, 12662.176958498037, 12693.238405695687, 12806.615801525597], "value": 8912.354115697479, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1436.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 110.0, 109.0, 108.0, 107.0, 109.0, 116.0, 97.0, 108.0, 110.0], "value": 108.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 115.0, 115.0, 117.0, 120.0, 116.0, 117.0, 119.0, 129.0, 120.0], "value": 118.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 164.0, 166.0, 165.0, 163.0, 173.0, 167.0, 163.0, 165.0], "value": 165.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 73.0, 74.0, 76.0, 73.0, 74.0, 76.0, 75.0, 75.0, 75.0], "value": 74.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 79.0, 79.0, 78.0, 79.0, 78.0, 78.0, 78.0, 80.0], "value": 78.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 115.0, 115.0, 115.0, 115.0], "value": 114.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 149.0, 148.0, 149.0, 147.0, 148.0, 151.0, 149.0, 152.0], "value": 149.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 94.0, 94.0, 96.0, 94.0, 97.0, 94.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 52.0, 64.0, 56.0, 55.0, 52.0, 53.0, 53.0, 51.0, 49.0], "value": 54.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 39.0, 39.0], "value": 38.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 75.0, 79.0, 86.0, 76.0, 77.0, 76.0, 76.0], "value": 76.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 128.0, 121.0, 124.0, 117.0, 141.0, 119.0, 128.0, 120.0, 120.0], "value": 124.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 181.0, 166.0, 176.0, 168.0, 170.0, 167.0, 174.0, 169.0, 172.0], "value": 172.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 69.0, 66.0, 71.0, 67.0, 66.0, 65.0, 66.0, 64.0, 65.0], "value": 66.5, "unit": "score"}]}]} 16:18:04 INFO - Return code: 0 16:18:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:18:04 INFO - # TBPL SUCCESS # 16:18:04 INFO - Running post-action listener: _package_coverage_data 16:18:04 INFO - Running post-action listener: _resource_record_post_action 16:18:04 INFO - [mozharness: 2017-09-07 23:18:04.390023Z] Finished run-tests step (success) 16:18:04 INFO - Running post-run listener: _resource_record_post_run 16:18:04 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 184320; Write bytes: 399884288; Read time: 96; Write time: 379272 16:18:04 INFO - TinderboxPrint: CPU usage
13.1% 16:18:04 INFO - TinderboxPrint: I/O read bytes / time
184,320 / 96 16:18:04 INFO - TinderboxPrint: I/O write bytes / time
399,884,288 / 379,272 16:18:04 INFO - TinderboxPrint: CPU idle
8,221.9 (86.8%) 16:18:04 INFO - TinderboxPrint: CPU user
1,194.2 (12.6%) 16:18:04 INFO - TinderboxPrint: Swap in / out
0 / 0 16:18:04 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 109936640; Read time: 0; Write time: 113240 16:18:04 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 16:18:04 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 184320; Write bytes: 281829376; Read time: 96; Write time: 265384 16:18:05 INFO - Running post-run listener: _upload_blobber_files 16:18:05 INFO - Blob upload gear active. 16:18:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:18:05 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:18:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:18:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:18:05 INFO - (blobuploader) - INFO - Open directory for files ... 16:18:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:18:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:18:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:18:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:18:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:18:06 INFO - (blobuploader) - INFO - Done attempting. 16:18:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:18:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:18:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:18:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:18:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:18:09 INFO - (blobuploader) - INFO - Done attempting. 16:18:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:18:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:18:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:18:10 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:18:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:18:10 INFO - (blobuploader) - INFO - Done attempting. 16:18:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:18:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:18:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:18:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:18:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:18:11 INFO - (blobuploader) - INFO - Done attempting. 16:18:11 INFO - (blobuploader) - INFO - Iteration through files over. 16:18:11 INFO - Return code: 0 16:18:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:18:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:18:11 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cee7bf54b059012440a8c41970e39f5a2380eda7c8026637d685e02dd3803a4d58731edaab50d4348232dc526c22c8fdf1e459fecb175f27ccfeb42fd89764b1", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/048569d85f6058ac2e47e729568055599e6f8c79a292289c4cbf8ffd426442dda479770294571f42d8453578542099adef3288cc89e434faf9d269b707bc2b26", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b5dbff0741d4cb14ac747d881581ecd5c2c6df5d22b642d58dee674f3f3c2cb84880c4ba6501d83d08e91d983ccee93d9897fb1d2117a417878678ad6705dcaf", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/76c45e3bc67f91a3b694d51c81048b9d645cfe3b71aaddb52cc1c8efd065fe232f320895fe81b4f2b06e961b5054a6a333b776cc790ad1743f5fd147211136c7"} 16:18:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:18:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:18:11 INFO - Contents: 16:18:11 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cee7bf54b059012440a8c41970e39f5a2380eda7c8026637d685e02dd3803a4d58731edaab50d4348232dc526c22c8fdf1e459fecb175f27ccfeb42fd89764b1", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/048569d85f6058ac2e47e729568055599e6f8c79a292289c4cbf8ffd426442dda479770294571f42d8453578542099adef3288cc89e434faf9d269b707bc2b26", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b5dbff0741d4cb14ac747d881581ecd5c2c6df5d22b642d58dee674f3f3c2cb84880c4ba6501d83d08e91d983ccee93d9897fb1d2117a417878678ad6705dcaf", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/76c45e3bc67f91a3b694d51c81048b9d645cfe3b71aaddb52cc1c8efd065fe232f320895fe81b4f2b06e961b5054a6a333b776cc790ad1743f5fd147211136c7"} 16:18:11 INFO - Running post-run listener: copy_logs_to_upload_dir 16:18:11 INFO - Copying logs to upload dir... 16:18:11 INFO - mkdir: /builds/slave/test/build/upload/logs 16:18:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.058463 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2017-09-07 16:18:11.714259) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-07 16:18:11.720465) ========= 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=52faae308a556c440401f8e5000001e8-1504825039.36694-854300185 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/cee7bf54b059012440a8c41970e39f5a2380eda7c8026637d685e02dd3803a4d58731edaab50d4348232dc526c22c8fdf1e459fecb175f27ccfeb42fd89764b1", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/048569d85f6058ac2e47e729568055599e6f8c79a292289c4cbf8ffd426442dda479770294571f42d8453578542099adef3288cc89e434faf9d269b707bc2b26", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b5dbff0741d4cb14ac747d881581ecd5c2c6df5d22b642d58dee674f3f3c2cb84880c4ba6501d83d08e91d983ccee93d9897fb1d2117a417878678ad6705dcaf", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/76c45e3bc67f91a3b694d51c81048b9d645cfe3b71aaddb52cc1c8efd065fe232f320895fe81b4f2b06e961b5054a6a333b776cc790ad1743f5fd147211136c7"} build_url:https://queue.taskcluster.net/v1/task/ZsNuXBl0Q92uv17nTmcSug/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011324 build_url: 'https://queue.taskcluster.net/v1/task/ZsNuXBl0Q92uv17nTmcSug/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cee7bf54b059012440a8c41970e39f5a2380eda7c8026637d685e02dd3803a4d58731edaab50d4348232dc526c22c8fdf1e459fecb175f27ccfeb42fd89764b1", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/048569d85f6058ac2e47e729568055599e6f8c79a292289c4cbf8ffd426442dda479770294571f42d8453578542099adef3288cc89e434faf9d269b707bc2b26", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b5dbff0741d4cb14ac747d881581ecd5c2c6df5d22b642d58dee674f3f3c2cb84880c4ba6501d83d08e91d983ccee93d9897fb1d2117a417878678ad6705dcaf", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/76c45e3bc67f91a3b694d51c81048b9d645cfe3b71aaddb52cc1c8efd065fe232f320895fe81b4f2b06e961b5054a6a333b776cc790ad1743f5fd147211136c7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-07 16:18:11.747990) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 16:18:11.748316) ========= 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=52faae308a556c440401f8e5000001e8-1504825039.36694-854300185 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004569 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 16:18:11.804191) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-07 16:18:11.804567) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-07 16:18:11.804872) ========= ========= Total master_lag: 0.14 =========