builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-081 starttime: 1504787901.24 results: success (0) revision: 6469a2cb7df662afb23493b5566f99b6802fcb5a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-07 05:38:21.240778) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-07 05:38:21.241233) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-07 05:38:21.241518) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-07 05:38:21.262043) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 05:38:21.262766) ========= 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=483e410453545d07cca6935c000001ab-1504787899.862163-2100156443 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-07 05:38:21-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 69.6M=0s 2017-09-07 05:38:21 (69.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.121430 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 05:38:21.408962) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 05:38:21.409276) ========= 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=483e410453545d07cca6935c000001ab-1504787899.862163-2100156443 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014677 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 05:38:21.463436) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-07 05:38:21.463783) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6469a2cb7df662afb23493b5566f99b6802fcb5a --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 6469a2cb7df662afb23493b5566f99b6802fcb5a --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=483e410453545d07cca6935c000001ab-1504787899.862163-2100156443 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-07 05:38:21,514 truncating revision to first 12 chars 2017-09-07 05:38:21,514 Setting DEBUG logging. 2017-09-07 05:38:21,514 attempt 1/10 2017-09-07 05:38:21,514 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6469a2cb7df6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-07 05:38:22,530 unpacking tar archive at: mozilla-central-6469a2cb7df6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.314955 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-07 05:38:22.795478) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-07 05:38:22.795839) ========= script_repo_revision: 6469a2cb7df662afb23493b5566f99b6802fcb5a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-07 05:38:22.796227) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-07 05:38:22.796846) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-07 05:38:22.809693) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2017-09-07 05:38:22.810023) ========= /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=483e410453545d07cca6935c000001ab-1504787899.862163-2100156443 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:38:22 INFO - MultiFileLogger online at 20170907 05:38:22 in /builds/slave/test 05:38:22 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:38:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:38:22 INFO - {'append_to_log': False, 05:38:22 INFO - 'base_work_dir': '/builds/slave/test', 05:38:22 INFO - 'blob_upload_branch': 'Firefox', 05:38:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:38:22 INFO - 'branch': 'Firefox', 05:38:22 INFO - 'buildbot_json_path': 'buildprops.json', 05:38:22 INFO - 'code_coverage': False, 05:38:22 INFO - 'config_files': ('talos/linux_config.py',), 05:38:22 INFO - 'default_actions': ('clobber', 05:38:22 INFO - 'read-buildbot-config', 05:38:22 INFO - 'download-and-extract', 05:38:22 INFO - 'populate-webroot', 05:38:22 INFO - 'create-virtualenv', 05:38:22 INFO - 'install', 05:38:22 INFO - 'setup-mitmproxy', 05:38:22 INFO - 'run-tests'), 05:38:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:38:22 INFO - 'disable_ccov_upload': False, 05:38:22 INFO - 'disable_stylo': False, 05:38:22 INFO - 'download_minidump_stackwalk': True, 05:38:22 INFO - 'download_symbols': 'ondemand', 05:38:22 INFO - 'enable_stylo': False, 05:38:22 INFO - 'enable_webrender': False, 05:38:22 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 05:38:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:38:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:38:23 INFO - 'gecko_profile': False, 05:38:23 INFO - 'gecko_profile_interval': 0, 05:38:23 INFO - 'installer_path': 'installer.exe', 05:38:23 INFO - 'log_level': 'info', 05:38:23 INFO - 'log_name': 'talos', 05:38:23 INFO - 'log_to_console': True, 05:38:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:38:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:38:23 INFO - 'opt_config_files': (), 05:38:23 INFO - 'pip_index': False, 05:38:23 INFO - 'suite': 'dromaeojs-e10s', 05:38:23 INFO - 'system_bits': '32', 05:38:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:38:23 INFO - 'title': 'talos-linux64-ix-081', 05:38:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:38:23 INFO - 'use_talos_json': True, 05:38:23 INFO - 'verify': 'False', 05:38:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:38:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:38:23 INFO - 'work_dir': 'build'} 05:38:23 INFO - [mozharness: 2017-09-07 12:38:23.005786Z] Running clobber step. 05:38:23 INFO - Running pre-action listener: _resource_record_pre_action 05:38:23 INFO - Running main action method: clobber 05:38:23 INFO - rmtree: /builds/slave/test/build 05:38:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:38:24 INFO - Running post-action listener: _resource_record_post_action 05:38:24 INFO - [mozharness: 2017-09-07 12:38:24.006542Z] Finished clobber step (success) 05:38:24 INFO - [mozharness: 2017-09-07 12:38:24.006639Z] Running read-buildbot-config step. 05:38:24 INFO - Running pre-action listener: _resource_record_pre_action 05:38:24 INFO - Running main action method: read_buildbot_config 05:38:24 INFO - Using buildbot properties: 05:38:24 INFO - { 05:38:24 INFO - "project": "", 05:38:24 INFO - "product": "firefox", 05:38:24 INFO - "who": "archaeopteryx@coole-files.de", 05:38:24 INFO - "installer_path": "public/build/target.tar.bz2", 05:38:24 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:38:24 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 05:38:24 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 05:38:24 INFO - "stage_platform": "linux64-pgo", 05:38:24 INFO - "basedir": "/builds/slave/test", 05:38:24 INFO - "buildnumber": 162, 05:38:24 INFO - "platform": "ubuntu64_hw", 05:38:24 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:38:24 INFO - "slavebuilddir": "test", 05:38:24 INFO - "taskId": "W-BqqhCFRuGxSn0-RkGA2g", 05:38:24 INFO - "branch": "mozilla-central", 05:38:24 INFO - "script_repo_revision": "production", 05:38:24 INFO - "revision": "6469a2cb7df662afb23493b5566f99b6802fcb5a", 05:38:24 INFO - "slavename": "talos-linux64-ix-081", 05:38:24 INFO - "repo_path": "mozilla-central" 05:38:24 INFO - } 05:38:24 INFO - Finding installer, test and symbols from parent task. 05:38:24 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/W-BqqhCFRuGxSn0-RkGA2g'}, attempt #1 05:38:24 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/W-BqqhCFRuGxSn0-RkGA2g'}, attempt #1 05:38:25 INFO - Task dependencies: THhrxJvGRaSBpbmI92T5WQ 05:38:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/THhrxJvGRaSBpbmI92T5WQ'}, attempt #1 05:38:25 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/THhrxJvGRaSBpbmI92T5WQ/artifacts/public/build/target.tar.bz2 05:38:25 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/THhrxJvGRaSBpbmI92T5WQ/artifacts/public/build/target.test_packages.json 05:38:25 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/THhrxJvGRaSBpbmI92T5WQ/artifacts/public/build/target.crashreporter-symbols.zip 05:38:25 INFO - Running post-action listener: _resource_record_post_action 05:38:25 INFO - [mozharness: 2017-09-07 12:38:25.457038Z] Finished read-buildbot-config step (success) 05:38:25 INFO - [mozharness: 2017-09-07 12:38:25.457253Z] Running download-and-extract step. 05:38:25 INFO - Running pre-action listener: _resource_record_pre_action 05:38:25 INFO - Running main action method: download_and_extract 05:38:25 INFO - mkdir: /builds/slave/test/build/tests 05:38:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:38:25 INFO - trying https://queue.taskcluster.net/v1/task/THhrxJvGRaSBpbmI92T5WQ/artifacts/public/build/target.test_packages.json 05:38:25 INFO - Downloading https://queue.taskcluster.net/v1/task/THhrxJvGRaSBpbmI92T5WQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 05:38:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/THhrxJvGRaSBpbmI92T5WQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 05:38:26 INFO - Downloaded 989 bytes. 05:38:26 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 05:38:26 INFO - Using the following test package requirements: 05:38:26 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 05:38:26 INFO - u'common': [u'target.common.tests.zip'], 05:38:26 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 05:38:26 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 05:38:26 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 05:38:26 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 05:38:26 INFO - u'mozbase': [u'target.common.tests.zip'], 05:38:26 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 05:38:26 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 05:38:26 INFO - u'web-platform': [u'target.common.tests.zip', 05:38:26 INFO - u'target.web-platform.tests.tar.gz'], 05:38:26 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 05:38:26 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 05:38:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/THhrxJvGRaSBpbmI92T5WQ/artifacts/public/build/target.common.tests.zip 05:38:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/THhrxJvGRaSBpbmI92T5WQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:38:26 INFO - Fetch https://queue.taskcluster.net/v1/task/THhrxJvGRaSBpbmI92T5WQ/artifacts/public/build/target.common.tests.zip into memory 05:38:27 INFO - Content-Length response header: 55692212 05:38:27 INFO - Bytes received: 55692212 05:38:38 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 05:38:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/THhrxJvGRaSBpbmI92T5WQ/artifacts/public/build/target.common.tests.zip 05:38:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/THhrxJvGRaSBpbmI92T5WQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:38:38 INFO - Fetch https://queue.taskcluster.net/v1/task/THhrxJvGRaSBpbmI92T5WQ/artifacts/public/build/target.common.tests.zip into memory 05:38:39 INFO - Content-Length response header: 55692212 05:38:39 INFO - Bytes received: 55692212 05:38:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/THhrxJvGRaSBpbmI92T5WQ/artifacts/public/build/target.talos.tests.zip 05:38:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/THhrxJvGRaSBpbmI92T5WQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 05:38:52 INFO - Fetch https://queue.taskcluster.net/v1/task/THhrxJvGRaSBpbmI92T5WQ/artifacts/public/build/target.talos.tests.zip into memory 05:38:52 INFO - Content-Length response header: 14496665 05:38:52 INFO - Bytes received: 14496665 05:38:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:38:53 INFO - trying https://queue.taskcluster.net/v1/task/THhrxJvGRaSBpbmI92T5WQ/artifacts/public/build/target.tar.bz2 05:38:53 INFO - Downloading https://queue.taskcluster.net/v1/task/THhrxJvGRaSBpbmI92T5WQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 05:38:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/THhrxJvGRaSBpbmI92T5WQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 05:38:54 INFO - Downloaded 63485289 bytes. 05:38:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/THhrxJvGRaSBpbmI92T5WQ/artifacts/public/build/target.tar.bz2 05:38:54 INFO - mkdir: /builds/slave/test/properties 05:38:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:38:54 INFO - Writing to file /builds/slave/test/properties/build_url 05:38:54 INFO - Contents: 05:38:54 INFO - build_url:https://queue.taskcluster.net/v1/task/THhrxJvGRaSBpbmI92T5WQ/artifacts/public/build/target.tar.bz2 05:38:54 INFO - Running post-action listener: _resource_record_post_action 05:38:54 INFO - Running post-action listener: find_tests_for_verification 05:38:54 INFO - Running post-action listener: set_extra_try_arguments 05:38:54 INFO - [mozharness: 2017-09-07 12:38:54.491218Z] Finished download-and-extract step (success) 05:38:54 INFO - [mozharness: 2017-09-07 12:38:54.491315Z] Running populate-webroot step. 05:38:54 INFO - Running pre-action listener: _resource_record_pre_action 05:38:54 INFO - Running main action method: populate_webroot 05:38:54 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:38:54 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:38:54 INFO - 'tests': ['tresize', 05:38:54 INFO - 'tcanvasmark']}, 05:38:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:38:54 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:38:54 INFO - 'tests': ['dromaeo_css', 05:38:54 INFO - 'kraken']}, 05:38:54 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:38:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:38:54 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 05:38:54 INFO - 'talos_options': ['--disable-stylo'], 05:38:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:38:54 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:38:54 INFO - 'tests': ['damp', 'tps']}, 05:38:54 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 05:38:54 INFO - 'talos_options': ['--disable-stylo'], 05:38:54 INFO - 'tests': ['damp', 'tps']}, 05:38:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:38:54 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:38:54 INFO - 'tests': ['dromaeo_dom']}, 05:38:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 05:38:54 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:38:54 INFO - 'tests': ['basic_compositor_video', 05:38:54 INFO - 'glvideo']}, 05:38:54 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 05:38:54 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 05:38:54 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 05:38:54 INFO - 'talos_options': ['--disable-stylo'], 05:38:54 INFO - 'tests': ['ts_paint_webext', 05:38:54 INFO - 'tp5o_webext']}, 05:38:54 INFO - 'other-e10s': {'tests': ['a11yr', 05:38:54 INFO - 'ts_paint', 05:38:54 INFO - 'tpaint', 05:38:54 INFO - 'sessionrestore', 05:38:54 INFO - 'sessionrestore_many_windows', 05:38:54 INFO - 'sessionrestore_no_auto_restore', 05:38:54 INFO - 'tabpaint']}, 05:38:54 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:38:54 INFO - 'tests': ['a11yr', 05:38:54 INFO - 'ts_paint', 05:38:54 INFO - 'tpaint', 05:38:54 INFO - 'sessionrestore', 05:38:54 INFO - 'sessionrestore_many_windows', 05:38:54 INFO - 'sessionrestore_no_auto_restore', 05:38:54 INFO - 'tabpaint']}, 05:38:54 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 05:38:54 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 05:38:54 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:38:54 INFO - 'tests': ['bloom_basic_singleton']}, 05:38:54 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:38:54 INFO - 'tests': ['bloom_basic']}, 05:38:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:38:54 INFO - 'tsvgr_opacity', 05:38:54 INFO - 'tart', 05:38:54 INFO - 'tscrollx', 05:38:54 INFO - 'tsvg_static']}, 05:38:54 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:38:54 INFO - 'tests': ['tsvgx', 05:38:54 INFO - 'tsvgr_opacity', 05:38:54 INFO - 'tart', 05:38:54 INFO - 'tscrollx', 05:38:54 INFO - 'tsvg_static']}, 05:38:54 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:38:54 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 05:38:54 INFO - 'talos_options': ['--disable-stylo'], 05:38:54 INFO - 'tests': ['tp5o']}, 05:38:54 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:38:54 INFO - 'talos_options': ['--mitmproxy', 05:38:54 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:38:54 INFO - '--firstNonBlankPaint'], 05:38:54 INFO - 'tests': ['tp6_google', 05:38:54 INFO - 'tp6_youtube', 05:38:54 INFO - 'tp6_amazon', 05:38:54 INFO - 'tp6_facebook']}, 05:38:54 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:38:54 INFO - 'talos_options': ['--disable-stylo', 05:38:54 INFO - '--mitmproxy', 05:38:54 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:38:54 INFO - '--firstNonBlankPaint'], 05:38:54 INFO - 'tests': ['tp6_google', 05:38:54 INFO - 'tp6_youtube', 05:38:54 INFO - 'tp6_amazon', 05:38:54 INFO - 'tp6_facebook']}, 05:38:54 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:38:54 INFO - 'talos_options': ['--stylo-threads=1', 05:38:54 INFO - '--mitmproxy', 05:38:54 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:38:54 INFO - '--firstNonBlankPaint'], 05:38:54 INFO - 'tests': ['tp6_google', 05:38:54 INFO - 'tp6_youtube', 05:38:54 INFO - 'tp6_amazon', 05:38:54 INFO - 'tp6_facebook']}, 05:38:54 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:38:54 INFO - 'talos_options': ['--xperf_path', 05:38:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:38:54 INFO - 'tests': ['tp5n']}, 05:38:54 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 05:38:54 INFO - 'talos_options': ['--disable-stylo', 05:38:54 INFO - '--xperf_path', 05:38:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:38:54 INFO - 'tests': ['tp5n']}}} 05:38:54 INFO - Running post-action listener: _resource_record_post_action 05:38:54 INFO - [mozharness: 2017-09-07 12:38:54.506314Z] Finished populate-webroot step (success) 05:38:54 INFO - [mozharness: 2017-09-07 12:38:54.506403Z] Running create-virtualenv step. 05:38:54 INFO - Running pre-action listener: _resource_record_pre_action 05:38:54 INFO - Running main action method: create_virtualenv 05:38:54 INFO - Creating virtualenv /builds/slave/test/build/venv 05:38:54 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:38:54 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 05:38:54 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 05:38:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:38:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:38:55 INFO - Installing distribute.............................................................................................................................................................................................done. 05:38:55 INFO - Installing pip...............done. 05:38:55 INFO - Return code: 0 05:38:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:38:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:38:55 INFO - Reading from file tmpfile_stdout 05:38:55 INFO - Output received: 05:38:55 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 05:38:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:38: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')]} 05:38:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:38: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')]} 05:38:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:38:55 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 0x1a461f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1db2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db6090>, '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 0x1db6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1db0f90>, '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': '483e410453545d07cca6935c000001ab-1504787899.862163-2100156443', '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 05:38:55 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 05:38:55 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 05:38:55 INFO - Using env: {'DISPLAY': ':0', 05:38:55 INFO - 'HOME': '/home/cltbld', 05:38:55 INFO - 'LANG': 'en_US.UTF-8', 05:38:55 INFO - 'LANGUAGE': 'en_US:en', 05:38:55 INFO - 'LOGNAME': 'cltbld', 05:38:55 INFO - 'MAIL': '/var/mail/cltbld', 05:38:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:38:55 INFO - 'MOZ_NO_REMOTE': '1', 05:38:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:38:55 INFO - 'NO_EM_RESTART': '1', 05:38:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:38:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:38:55 INFO - 'PWD': '/builds/slave/test', 05:38:55 INFO - 'SHELL': '/bin/bash', 05:38:55 INFO - 'SHLVL': '1', 05:38:55 INFO - 'TERM': 'linux', 05:38:55 INFO - 'TMOUT': '86400', 05:38:55 INFO - 'USER': 'cltbld', 05:38:55 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1504787899.862163-2100156443', 05:38:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:38:55 INFO - '_': '/tools/buildbot/bin/python'} 05:38:56 INFO - Ignoring indexes: http://pypi.python.org/simple/ 05:38:56 INFO - Downloading/unpacking pip>=1.5 05:38:56 INFO - Running setup.py egg_info for package pip 05:38:56 INFO - warning: no files found matching 'pip/cacert.pem' 05:38:56 INFO - warning: no files found matching '*.html' under directory 'docs' 05:38:56 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 05:38:56 INFO - no previously-included directories found matching 'docs/_build/_sources' 05:38:56 INFO - Installing collected packages: pip 05:38:56 INFO - Found existing installation: pip 1.1 05:38:56 INFO - Uninstalling pip: 05:38:56 INFO - Successfully uninstalled pip 05:38:56 INFO - Running setup.py install for pip 05:38:56 INFO - warning: no files found matching 'pip/cacert.pem' 05:38:56 INFO - warning: no files found matching '*.html' under directory 'docs' 05:38:56 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 05:38:56 INFO - no previously-included directories found matching 'docs/_build/_sources' 05:38:56 INFO - Installing pip script to /builds/slave/test/build/venv/bin 05:38:56 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 05:38:56 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 05:38:56 INFO - Successfully installed pip 05:38:56 INFO - Cleaning up... 05:38:56 INFO - Return code: 0 05:38:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:38:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:38:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:38:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:38:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:38:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a461f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1db2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db6090>, '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 0x1db6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1db0f90>, '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': '483e410453545d07cca6935c000001ab-1504787899.862163-2100156443', '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 05:38:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:38:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:38:56 INFO - Using env: {'DISPLAY': ':0', 05:38:56 INFO - 'HOME': '/home/cltbld', 05:38:56 INFO - 'LANG': 'en_US.UTF-8', 05:38:56 INFO - 'LANGUAGE': 'en_US:en', 05:38:56 INFO - 'LOGNAME': 'cltbld', 05:38:56 INFO - 'MAIL': '/var/mail/cltbld', 05:38:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:38:56 INFO - 'MOZ_NO_REMOTE': '1', 05:38:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:38:56 INFO - 'NO_EM_RESTART': '1', 05:38:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:38:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:38:56 INFO - 'PWD': '/builds/slave/test', 05:38:56 INFO - 'SHELL': '/bin/bash', 05:38:56 INFO - 'SHLVL': '1', 05:38:56 INFO - 'TERM': 'linux', 05:38:56 INFO - 'TMOUT': '86400', 05:38:56 INFO - 'USER': 'cltbld', 05:38:56 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1504787899.862163-2100156443', 05:38:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:38:56 INFO - '_': '/tools/buildbot/bin/python'} 05:38:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:38:56 INFO - Downloading/unpacking psutil>=3.1.1 05:38:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:38:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:38:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:38:58 INFO - Installing collected packages: psutil 05:38:58 INFO - Running setup.py install for psutil 05:38:58 INFO - building 'psutil._psutil_linux' extension 05:38:58 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 05:38:58 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:38:58 INFO - building 'psutil._psutil_posix' extension 05:38:58 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:38:58 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:38:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:38:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:38:58 INFO - Successfully installed psutil 05:38:58 INFO - Cleaning up... 05:38:58 INFO - Return code: 0 05:38:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:38: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')]} 05:38:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:38: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')]} 05:38:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:38:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a461f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1db2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db6090>, '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 0x1db6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1db0f90>, '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': '483e410453545d07cca6935c000001ab-1504787899.862163-2100156443', '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 05:38:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:38:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:38:58 INFO - Using env: {'DISPLAY': ':0', 05:38:58 INFO - 'HOME': '/home/cltbld', 05:38:58 INFO - 'LANG': 'en_US.UTF-8', 05:38:58 INFO - 'LANGUAGE': 'en_US:en', 05:38:58 INFO - 'LOGNAME': 'cltbld', 05:38:58 INFO - 'MAIL': '/var/mail/cltbld', 05:38:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:38:58 INFO - 'MOZ_NO_REMOTE': '1', 05:38:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:38:58 INFO - 'NO_EM_RESTART': '1', 05:38:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:38:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:38:58 INFO - 'PWD': '/builds/slave/test', 05:38:58 INFO - 'SHELL': '/bin/bash', 05:38:58 INFO - 'SHLVL': '1', 05:38:58 INFO - 'TERM': 'linux', 05:38:58 INFO - 'TMOUT': '86400', 05:38:58 INFO - 'USER': 'cltbld', 05:38:58 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1504787899.862163-2100156443', 05:38:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:38:58 INFO - '_': '/tools/buildbot/bin/python'} 05:38:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:38:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:38: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 05:38: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 05:38: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 05:38: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 05:38:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:38:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:39:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:39:00 INFO - Installing collected packages: mozsystemmonitor 05:39:00 INFO - Running setup.py install for mozsystemmonitor 05:39:00 INFO - Successfully installed mozsystemmonitor 05:39:00 INFO - Cleaning up... 05:39:00 INFO - Return code: 0 05:39:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:39: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')]} 05:39:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39: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')]} 05:39:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39: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', '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 0x1a461f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1db2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db6090>, '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 0x1db6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1db0f90>, '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': '483e410453545d07cca6935c000001ab-1504787899.862163-2100156443', '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 05:39: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:39: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 jsonschema==2.5.1 05:39:00 INFO - Using env: {'DISPLAY': ':0', 05:39:00 INFO - 'HOME': '/home/cltbld', 05:39:00 INFO - 'LANG': 'en_US.UTF-8', 05:39:00 INFO - 'LANGUAGE': 'en_US:en', 05:39:00 INFO - 'LOGNAME': 'cltbld', 05:39:00 INFO - 'MAIL': '/var/mail/cltbld', 05:39:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:00 INFO - 'MOZ_NO_REMOTE': '1', 05:39:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:00 INFO - 'NO_EM_RESTART': '1', 05:39:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:00 INFO - 'PWD': '/builds/slave/test', 05:39:00 INFO - 'SHELL': '/bin/bash', 05:39:00 INFO - 'SHLVL': '1', 05:39:00 INFO - 'TERM': 'linux', 05:39:00 INFO - 'TMOUT': '86400', 05:39:00 INFO - 'USER': 'cltbld', 05:39:00 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1504787899.862163-2100156443', 05:39:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:00 INFO - '_': '/tools/buildbot/bin/python'} 05:39:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:00 INFO - Downloading/unpacking jsonschema==2.5.1 05:39: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 05:39: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 05:39: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 05:39: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 05:39:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:39:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:39:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:01 INFO - Downloading functools32-3.2.3-2.tar.gz 05:39:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:39:01 INFO - warning: no files found matching '*.txt' 05:39:01 INFO - no previously-included directories found matching 'build' 05:39:01 INFO - no previously-included directories found matching 'dist' 05:39:01 INFO - no previously-included directories found matching '.git*' 05:39:01 INFO - Installing collected packages: jsonschema, functools32 05:39:01 INFO - Running setup.py install for functools32 05:39:01 INFO - warning: no files found matching '*.txt' 05:39:01 INFO - no previously-included directories found matching 'build' 05:39:01 INFO - no previously-included directories found matching 'dist' 05:39:01 INFO - no previously-included directories found matching '.git*' 05:39:01 INFO - Successfully installed jsonschema functools32 05:39:01 INFO - Cleaning up... 05:39:01 INFO - Return code: 0 05:39:01 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:39:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a461f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1db2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db6090>, '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 0x1db6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1db0f90>, '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': '483e410453545d07cca6935c000001ab-1504787899.862163-2100156443', '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 05:39:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:39:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:39:01 INFO - Using env: {'DISPLAY': ':0', 05:39:01 INFO - 'HOME': '/home/cltbld', 05:39:01 INFO - 'LANG': 'en_US.UTF-8', 05:39:01 INFO - 'LANGUAGE': 'en_US:en', 05:39:01 INFO - 'LOGNAME': 'cltbld', 05:39:01 INFO - 'MAIL': '/var/mail/cltbld', 05:39:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:01 INFO - 'MOZ_NO_REMOTE': '1', 05:39:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:01 INFO - 'NO_EM_RESTART': '1', 05:39:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:01 INFO - 'PWD': '/builds/slave/test', 05:39:01 INFO - 'SHELL': '/bin/bash', 05:39:01 INFO - 'SHLVL': '1', 05:39:01 INFO - 'TERM': 'linux', 05:39:01 INFO - 'TMOUT': '86400', 05:39:01 INFO - 'USER': 'cltbld', 05:39:01 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1504787899.862163-2100156443', 05:39:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:01 INFO - '_': '/tools/buildbot/bin/python'} 05:39:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:39:02 INFO - Cleaning up... 05:39:02 INFO - Return code: 0 05:39:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:39: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')]} 05:39:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39: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')]} 05:39:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39: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', '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 0x1a461f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1db2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db6090>, '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 0x1db6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1db0f90>, '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': '483e410453545d07cca6935c000001ab-1504787899.862163-2100156443', '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 05:39: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:39: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 blobuploader==1.2.4 05:39:02 INFO - Using env: {'DISPLAY': ':0', 05:39:02 INFO - 'HOME': '/home/cltbld', 05:39:02 INFO - 'LANG': 'en_US.UTF-8', 05:39:02 INFO - 'LANGUAGE': 'en_US:en', 05:39:02 INFO - 'LOGNAME': 'cltbld', 05:39:02 INFO - 'MAIL': '/var/mail/cltbld', 05:39:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:02 INFO - 'MOZ_NO_REMOTE': '1', 05:39:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:02 INFO - 'NO_EM_RESTART': '1', 05:39:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:02 INFO - 'PWD': '/builds/slave/test', 05:39:02 INFO - 'SHELL': '/bin/bash', 05:39:02 INFO - 'SHLVL': '1', 05:39:02 INFO - 'TERM': 'linux', 05:39:02 INFO - 'TMOUT': '86400', 05:39:02 INFO - 'USER': 'cltbld', 05:39:02 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1504787899.862163-2100156443', 05:39:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:02 INFO - '_': '/tools/buildbot/bin/python'} 05:39:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:02 INFO - Downloading/unpacking blobuploader==1.2.4 05:39: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 05:39: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 05:39: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 05:39: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 05:39:03 INFO - Downloading blobuploader-1.2.4.tar.gz 05:39:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:39:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:39: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 05:39: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 05:39: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 05:39: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 05:39:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:39:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:39: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 05:39: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 05:39: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 05:39: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 05:39:03 INFO - Downloading docopt-0.6.1.tar.gz 05:39:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:39:03 INFO - Installing collected packages: blobuploader, requests, docopt 05:39:03 INFO - Running setup.py install for blobuploader 05:39:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:39:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:39:04 INFO - Running setup.py install for requests 05:39:04 INFO - Running setup.py install for docopt 05:39:04 INFO - Successfully installed blobuploader requests docopt 05:39:04 INFO - Cleaning up... 05:39:04 INFO - Return code: 0 05:39:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:39: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')]} 05:39:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39: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')]} 05:39:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a461f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1db2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db6090>, '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 0x1db6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1db0f90>, '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': '483e410453545d07cca6935c000001ab-1504787899.862163-2100156443', '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 05:39:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:39:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:39:04 INFO - Using env: {'DISPLAY': ':0', 05:39:04 INFO - 'HOME': '/home/cltbld', 05:39:04 INFO - 'LANG': 'en_US.UTF-8', 05:39:04 INFO - 'LANGUAGE': 'en_US:en', 05:39:04 INFO - 'LOGNAME': 'cltbld', 05:39:04 INFO - 'MAIL': '/var/mail/cltbld', 05:39:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:04 INFO - 'MOZ_NO_REMOTE': '1', 05:39:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:04 INFO - 'NO_EM_RESTART': '1', 05:39:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:04 INFO - 'PWD': '/builds/slave/test', 05:39:04 INFO - 'SHELL': '/bin/bash', 05:39:04 INFO - 'SHLVL': '1', 05:39:04 INFO - 'TERM': 'linux', 05:39:04 INFO - 'TMOUT': '86400', 05:39:04 INFO - 'USER': 'cltbld', 05:39:04 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1504787899.862163-2100156443', 05:39:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:04 INFO - '_': '/tools/buildbot/bin/python'} 05:39:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:39:04 INFO - Running setup.py (path:/tmp/pip-vKkvv7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:39:04 INFO - Running setup.py (path:/tmp/pip-bhm6yN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:39:04 INFO - Running setup.py (path:/tmp/pip-7tD3X0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:39:04 INFO - Running setup.py (path:/tmp/pip-5UlBqo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:39:05 INFO - Running setup.py (path:/tmp/pip-xFUEas-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:39:05 INFO - Running setup.py (path:/tmp/pip-JPvDar-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:39:05 INFO - Running setup.py (path:/tmp/pip-YJVvI9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:39:05 INFO - Running setup.py (path:/tmp/pip-jvXtmn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:39:05 INFO - Running setup.py (path:/tmp/pip-jksl1d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:39:05 INFO - Running setup.py (path:/tmp/pip-_dsHhb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:39:05 INFO - Running setup.py (path:/tmp/pip-QvbQM4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:39:05 INFO - Running setup.py (path:/tmp/pip-EySRTs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:39:05 INFO - Running setup.py (path:/tmp/pip-1xrGEq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:39:05 INFO - Running setup.py (path:/tmp/pip-dMrgKc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:39:05 INFO - Running setup.py (path:/tmp/pip-jsMsfh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:39:05 INFO - Running setup.py (path:/tmp/pip-fOHE6R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:39:05 INFO - Running setup.py (path:/tmp/pip-LGxfAI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:39:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:39:05 INFO - Running setup.py install for manifestparser 05:39:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:39:06 INFO - Running setup.py install for mozcrash 05:39:06 INFO - Running setup.py install for mozdebug 05:39:06 INFO - Running setup.py install for mozdevice 05:39:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:39:06 INFO - Running setup.py install for mozfile 05:39:06 INFO - Running setup.py install for mozhttpd 05:39:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:39:06 INFO - Running setup.py install for mozinfo 05:39:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:39:06 INFO - Running setup.py install for mozInstall 05:39:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:39:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:39:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:39:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:39:06 INFO - Running setup.py install for mozleak 05:39:06 INFO - Running setup.py install for mozlog 05:39:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:39:06 INFO - Running setup.py install for moznetwork 05:39:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:39:07 INFO - Running setup.py install for mozprocess 05:39:07 INFO - Running setup.py install for mozprofile 05:39:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:39:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:39:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:39:07 INFO - Running setup.py install for mozrunner 05:39:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:39:07 INFO - Running setup.py install for mozscreenshot 05:39:07 INFO - Running setup.py install for moztest 05:39:07 INFO - Running setup.py install for mozversion 05:39:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:39:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:39:07 INFO - Cleaning up... 05:39:07 INFO - Return code: 0 05:39:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:39:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a461f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1db2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db6090>, '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 0x1db6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1db0f90>, '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': '483e410453545d07cca6935c000001ab-1504787899.862163-2100156443', '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 05:39:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:39:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:39:07 INFO - Using env: {'DISPLAY': ':0', 05:39:07 INFO - 'HOME': '/home/cltbld', 05:39:07 INFO - 'LANG': 'en_US.UTF-8', 05:39:07 INFO - 'LANGUAGE': 'en_US:en', 05:39:07 INFO - 'LOGNAME': 'cltbld', 05:39:07 INFO - 'MAIL': '/var/mail/cltbld', 05:39:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:07 INFO - 'MOZ_NO_REMOTE': '1', 05:39:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:07 INFO - 'NO_EM_RESTART': '1', 05:39:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:07 INFO - 'PWD': '/builds/slave/test', 05:39:07 INFO - 'SHELL': '/bin/bash', 05:39:07 INFO - 'SHLVL': '1', 05:39:07 INFO - 'TERM': 'linux', 05:39:07 INFO - 'TMOUT': '86400', 05:39:07 INFO - 'USER': 'cltbld', 05:39:07 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1504787899.862163-2100156443', 05:39:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:07 INFO - '_': '/tools/buildbot/bin/python'} 05:39:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:39:07 INFO - Running setup.py (path:/tmp/pip-DYan8_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:39:07 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:39:07 INFO - Running setup.py (path:/tmp/pip-ZaUMn9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:39:08 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)) 05:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:39:08 INFO - Running setup.py (path:/tmp/pip-tKugb5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:39:08 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)) 05:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:39:08 INFO - Running setup.py (path:/tmp/pip-rA6Ctf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:39:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:39:08 INFO - Running setup.py (path:/tmp/pip-QffEqP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:39:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:39:08 INFO - Running setup.py (path:/tmp/pip-1lEMoo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:39:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:39:08 INFO - Running setup.py (path:/tmp/pip-Wr57nO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:39:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:39:08 INFO - Running setup.py (path:/tmp/pip-4wpy_y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:39:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:39:08 INFO - Running setup.py (path:/tmp/pip-2H3pOO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:39:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:39:08 INFO - Running setup.py (path:/tmp/pip-0qfTPo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:39:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:39:08 INFO - Running setup.py (path:/tmp/pip-xO4NFG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:39:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:39:08 INFO - Running setup.py (path:/tmp/pip-Bpa1kP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:39:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:39:08 INFO - Running setup.py (path:/tmp/pip-naDvI_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:39:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:39:08 INFO - Running setup.py (path:/tmp/pip-ABETs3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:39:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:39:08 INFO - Running setup.py (path:/tmp/pip-MYTN04-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:39:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:39:08 INFO - Running setup.py (path:/tmp/pip-VzZKcQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:39:09 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)) 05:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:39:09 INFO - Running setup.py (path:/tmp/pip-3GfVmb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:39:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:39:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:39:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:39:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:39:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:39:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:39:09 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:39:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:39:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:10 INFO - Downloading blessings-1.6.tar.gz 05:39:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:39:10 INFO - Installing collected packages: blessings 05:39:10 INFO - Running setup.py install for blessings 05:39:10 INFO - Successfully installed blessings 05:39:10 INFO - Cleaning up... 05:39:10 INFO - Return code: 0 05:39:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:39:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:39:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:39:10 INFO - Reading from file tmpfile_stdout 05:39:10 INFO - Current package versions: 05:39:10 INFO - argparse == 1.2.1 05:39:10 INFO - blessings == 1.6 05:39:10 INFO - blobuploader == 1.2.4 05:39:10 INFO - docopt == 0.6.1 05:39:10 INFO - functools32 == 3.2.3-2 05:39:10 INFO - jsonschema == 2.5.1 05:39:10 INFO - manifestparser == 1.1 05:39:10 INFO - mozInstall == 1.13 05:39:10 INFO - mozcrash == 1.0 05:39:10 INFO - mozdebug == 0.1 05:39:10 INFO - mozdevice == 0.51 05:39:10 INFO - mozfile == 1.2 05:39:10 INFO - mozhttpd == 0.7 05:39:10 INFO - mozinfo == 0.10 05:39:10 INFO - mozleak == 0.1 05:39:10 INFO - mozlog == 3.5 05:39:10 INFO - moznetwork == 0.27 05:39:10 INFO - mozprocess == 0.25 05:39:10 INFO - mozprofile == 0.28 05:39:10 INFO - mozrunner == 6.13 05:39:10 INFO - mozscreenshot == 0.1 05:39:10 INFO - mozsystemmonitor == 0.3 05:39:10 INFO - moztest == 0.8 05:39:10 INFO - mozversion == 1.4 05:39:10 INFO - psutil == 3.1.1 05:39:10 INFO - requests == 1.2.3 05:39:10 INFO - wsgiref == 0.1.2 05:39:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:39:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a461f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1db2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db6090>, '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 0x1db6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1db0f90>, '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': '483e410453545d07cca6935c000001ab-1504787899.862163-2100156443', '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 05:39:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:39:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:39:10 INFO - Using env: {'DISPLAY': ':0', 05:39:10 INFO - 'HOME': '/home/cltbld', 05:39:10 INFO - 'LANG': 'en_US.UTF-8', 05:39:10 INFO - 'LANGUAGE': 'en_US:en', 05:39:10 INFO - 'LOGNAME': 'cltbld', 05:39:10 INFO - 'MAIL': '/var/mail/cltbld', 05:39:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:10 INFO - 'MOZ_NO_REMOTE': '1', 05:39:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:10 INFO - 'NO_EM_RESTART': '1', 05:39:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:10 INFO - 'PWD': '/builds/slave/test', 05:39:10 INFO - 'SHELL': '/bin/bash', 05:39:10 INFO - 'SHLVL': '1', 05:39:10 INFO - 'TERM': 'linux', 05:39:10 INFO - 'TMOUT': '86400', 05:39:10 INFO - 'USER': 'cltbld', 05:39:10 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1504787899.862163-2100156443', 05:39:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:10 INFO - '_': '/tools/buildbot/bin/python'} 05:39:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:39:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:39:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:39:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:39:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:39:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:39:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:39:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:39:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:39:10 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 05:39:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 05:39:12 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)) 05:39:12 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)) 05:39:12 INFO - Installing collected packages: simplejson 05:39:12 INFO - Running setup.py install for simplejson 05:39:12 INFO - building 'simplejson._speedups' extension 05:39:12 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 05:39:12 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 05:39:13 INFO - Successfully installed simplejson 05:39:13 INFO - Cleaning up... 05:39:13 INFO - Return code: 0 05:39:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:39:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a461f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1db2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db6090>, '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 0x1db6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1db0f90>, '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': '483e410453545d07cca6935c000001ab-1504787899.862163-2100156443', '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 05:39:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:39:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:39:13 INFO - Using env: {'DISPLAY': ':0', 05:39:13 INFO - 'HOME': '/home/cltbld', 05:39:13 INFO - 'LANG': 'en_US.UTF-8', 05:39:13 INFO - 'LANGUAGE': 'en_US:en', 05:39:13 INFO - 'LOGNAME': 'cltbld', 05:39:13 INFO - 'MAIL': '/var/mail/cltbld', 05:39:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:13 INFO - 'MOZ_NO_REMOTE': '1', 05:39:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:13 INFO - 'NO_EM_RESTART': '1', 05:39:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:13 INFO - 'PWD': '/builds/slave/test', 05:39:13 INFO - 'SHELL': '/bin/bash', 05:39:13 INFO - 'SHLVL': '1', 05:39:13 INFO - 'TERM': 'linux', 05:39:13 INFO - 'TMOUT': '86400', 05:39:13 INFO - 'USER': 'cltbld', 05:39:13 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1504787899.862163-2100156443', 05:39:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:13 INFO - '_': '/tools/buildbot/bin/python'} 05:39:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:39:13 INFO - Cleaning up... 05:39:13 INFO - Return code: 0 05:39:13 INFO - Running post-action listener: _resource_record_post_action 05:39:13 INFO - Running post-action listener: _start_resource_monitoring 05:39:13 INFO - Starting resource monitoring. 05:39:13 INFO - [mozharness: 2017-09-07 12:39:13.372385Z] Finished create-virtualenv step (success) 05:39:13 INFO - [mozharness: 2017-09-07 12:39:13.373041Z] Running install step. 05:39:13 INFO - Running pre-action listener: _resource_record_pre_action 05:39:13 INFO - Running main action method: install 05:39:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:39:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:39:13 INFO - Reading from file tmpfile_stdout 05:39:13 INFO - Detecting whether we're running mozinstall >=1.0... 05:39:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:39:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:39:13 INFO - Reading from file tmpfile_stdout 05:39:13 INFO - Output received: 05:39:13 INFO - Usage: mozinstall [options] installer 05:39:13 INFO - Options: 05:39:13 INFO - -h, --help show this help message and exit 05:39:13 INFO - -d DEST, --destination=DEST 05:39:13 INFO - Directory to install application into. [default: 05:39:13 INFO - "/builds/slave/test"] 05:39:13 INFO - --app=APP Application being installed. [default: firefox] 05:39:13 INFO - mkdir: /builds/slave/test/build/application 05:39:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:39:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 05:39:30 INFO - Reading from file tmpfile_stdout 05:39:30 INFO - Output received: 05:39:30 INFO - /builds/slave/test/build/application/firefox/firefox 05:39:30 INFO - Running post-action listener: _resource_record_post_action 05:39:30 INFO - [mozharness: 2017-09-07 12:39:30.062428Z] Finished install step (success) 05:39:30 INFO - [mozharness: 2017-09-07 12:39:30.062679Z] Running setup-mitmproxy step. 05:39:30 INFO - Running pre-action listener: _resource_record_pre_action 05:39:30 INFO - Running main action method: setup_mitmproxy 05:39:30 INFO - Skipping: mitmproxy is not required 05:39:30 INFO - Running post-action listener: _resource_record_post_action 05:39:30 INFO - [mozharness: 2017-09-07 12:39:30.063817Z] Finished setup-mitmproxy step (success) 05:39:30 INFO - [mozharness: 2017-09-07 12:39:30.064034Z] Running run-tests step. 05:39:30 INFO - Running pre-action listener: _resource_record_pre_action 05:39:30 INFO - Running pre-action listener: _set_gcov_prefix 05:39:30 INFO - Running main action method: run_tests 05:39:30 WARNING - Try message not found. 05:39:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:39:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:39:30 INFO - Python 2.7.3 05:39:30 INFO - Return code: 0 05:39:30 INFO - grabbing minidump binary from tooltool 05:39:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:30 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 0x1db6090>, '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 0x1db6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1db0f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:39:30 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 05:39:30 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 05:39:30 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 05:39:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:39:30 INFO - Return code: 0 05:39:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:39:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:39:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:39:30 INFO - ENV: RUST_BACKTRACE is now full 05:39:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:39:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:39:30 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/THhrxJvGRaSBpbmI92T5WQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-081', '--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 05:39:30 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/THhrxJvGRaSBpbmI92T5WQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-081 --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 05:39:30 INFO - Using env: {'DISPLAY': ':0', 05:39:30 INFO - 'HOME': '/home/cltbld', 05:39:30 INFO - 'LANG': 'en_US.UTF-8', 05:39:30 INFO - 'LANGUAGE': 'en_US:en', 05:39:30 INFO - 'LOGNAME': 'cltbld', 05:39:30 INFO - 'MAIL': '/var/mail/cltbld', 05:39:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:39:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:39:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:30 INFO - 'MOZ_NO_REMOTE': '1', 05:39:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:39:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:30 INFO - 'NO_EM_RESTART': '1', 05:39:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:30 INFO - 'PWD': '/builds/slave/test', 05:39:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:39:30 INFO - 'RUST_BACKTRACE': 'full', 05:39:30 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 05:39:30 INFO - 'SHELL': '/bin/bash', 05:39:30 INFO - 'SHLVL': '1', 05:39:30 INFO - 'TERM': 'linux', 05:39:30 INFO - 'TMOUT': '86400', 05:39:30 INFO - 'USER': 'cltbld', 05:39:30 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1504787899.862163-2100156443', 05:39:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:30 INFO - '_': '/tools/buildbot/bin/python'} 05:39:30 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/THhrxJvGRaSBpbmI92T5WQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-081', '--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 05:39:30 INFO - mozversion application_buildid: 20170907103107 05:39:30 INFO - mozversion application_changeset: 6469a2cb7df662afb23493b5566f99b6802fcb5a 05:39:30 INFO - mozversion application_display_name: Nightly 05:39:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:39:30 INFO - mozversion application_name: Firefox 05:39:30 INFO - mozversion application_remotingname: firefox 05:39:30 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:39:30 INFO - mozversion application_vendor: Mozilla 05:39:30 INFO - mozversion application_version: 57.0a1 05:39:30 INFO - mozversion platform_buildid: 20170907103107 05:39:30 INFO - mozversion platform_changeset: 6469a2cb7df662afb23493b5566f99b6802fcb5a 05:39:30 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:39:30 INFO - mozversion platform_version: 57.0a1 05:39:30 INFO - using testdate: 1504787970 05:39:30 INFO - actual date: 1504787970 05:39:30 INFO - starting webserver on 'localhost:34151' 05:39:30 INFO - SUITE-START | Running 2 tests 05:39:30 INFO - TEST-START | dromaeo_css 05:39:30 INFO - Initialising browser for dromaeo_css test... 05:39:30 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:34151/getInfo.html -profile /tmp/tmpldZQRP/profile 05:39:30 INFO - TEST-INFO | started process 4387 (/builds/slave/test/build/application/firefox/firefox http://localhost:34151/getInfo.html) 05:39:36 INFO - TEST-INFO | 4387: exit 0 05:39:36 INFO - Browser initialized. 05:39:36 INFO - Running cycle 1/1 for dromaeo_css test... 05:39:36 INFO - Using env: {'DISPLAY': ':0', 05:39:36 INFO - 'HOME': '/home/cltbld', 05:39:36 INFO - 'JSGC_DISABLE_POISONING': '1', 05:39:36 INFO - 'LANG': 'en_US.UTF-8', 05:39:36 INFO - 'LANGUAGE': 'en_US:en', 05:39:36 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 05:39:36 INFO - 'LOGNAME': 'cltbld', 05:39:36 INFO - 'MAIL': '/var/mail/cltbld', 05:39:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:39:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:39:36 INFO - 'MOZ_CRASHREPORTER': '1', 05:39:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:36 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 05:39:36 INFO - 'MOZ_NO_REMOTE': '1', 05:39:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:39:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:36 INFO - 'NO_EM_RESTART': '1', 05:39:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:36 INFO - 'PWD': '/builds/slave/test', 05:39:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:39:36 INFO - 'RUST_BACKTRACE': 'full', 05:39:36 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 05:39:36 INFO - 'SHELL': '/bin/bash', 05:39:36 INFO - 'SHLVL': '1', 05:39:36 INFO - 'TERM': 'linux', 05:39:36 INFO - 'TMOUT': '86400', 05:39:36 INFO - 'USER': 'cltbld', 05:39:36 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1504787899.862163-2100156443', 05:39:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:36 INFO - '_': '/tools/buildbot/bin/python'} 05:39:36 INFO - TEST-INFO | started process 4585 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpldZQRP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:39:36 INFO - PID 4585 | 05:39:36 INFO - PID 4585 | (/builds/slave/test/build/application/firefox/firefox:4636): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 05:39:36 INFO - PID 4585 | 05:39:47 INFO - PID 4585 | RSS: Main: 164032512 05:39:47 INFO - PID 4585 | 05:42:43 INFO - PID 4585 | Cycle 1(1): loaded http://localhost:34151/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34151/tests/dromaeo/cssquery-ext.html) 05:42:45 INFO - PID 4585 | RSS: Main: 167469056 05:42:45 INFO - PID 4585 | 05:45:46 INFO - PID 4585 | Cycle 1(1): loaded http://localhost:34151/tests/dromaeo/cssquery-ext.html (next: http://localhost:34151/tests/dromaeo/cssquery-jquery.html) 05:45:47 INFO - PID 4585 | RSS: Main: 163602432 05:45:47 INFO - PID 4585 | 05:48:49 INFO - PID 4585 | Cycle 1(1): loaded http://localhost:34151/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34151/tests/dromaeo/cssquery-mootools.html) 05:48:49 INFO - PID 4585 | RSS: Main: 166146048 05:48:49 INFO - PID 4585 | 05:51:51 INFO - PID 4585 | Cycle 1(1): loaded http://localhost:34151/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34151/tests/dromaeo/cssquery-prototype.html) 05:51:51 INFO - PID 4585 | RSS: Main: 164900864 05:51:51 INFO - PID 4585 | 05:54:55 INFO - PID 4585 | Cycle 1(1): loaded http://localhost:34151/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34151/tests/dromaeo/cssquery-yui.html) 05:54:55 INFO - PID 4585 | RSS: Main: 166461440 05:54:55 INFO - PID 4585 | 05:57:57 INFO - PID 4585 | Cycle 1(1): loaded http://localhost:34151/tests/dromaeo/cssquery-yui.html (next: http://localhost:34151/tests/dromaeo/cssquery-dojo.html) 05:57:57 INFO - PID 4585 | RSS: Main: 168927232 05:57:57 INFO - PID 4585 | 05:57:57 INFO - PID 4585 | __start_tp_report 05:57:57 INFO - PID 4585 | _x_x_mozilla_page_load 05:57:57 INFO - PID 4585 | _x_x_mozilla_page_load_details 05:57:57 INFO - PID 4585 | |i|pagename|runs| 05:57:57 INFO - PID 4585 | |0;dojo.html;3840.7887566183867;3886.378179491281;3887.2614203301364;3894.7273690841653;3903.3754599264125;6267.968660156698;6403.7438502459845;6466.450351720104;6480.967595162024;6502.707378167982;6300.30696623371;6406.199225096863;6416.486681065515;6436.292007879129;6437.806865794022;5663.546916246691;5666.660000399979;5677.034904066319;5711.485966263035;5725.942740572604;5725.513331366838;5727;5732.541396688276;5779.335376431723;5797.36229014808;5770.134479828039;5805.970970145143;5812.3025236971625;5818.301803783552;5851.531877449794;5697.145428185764;5722.914156287659;5818.214541036969;5824.650520968713;5831.854203644943;5511.641743286674;5657.09486482165;5669.546436285087;5671.971640141773;5813.593048486608;6337.144485494446;6347.777827776005;6349.396807303298;6367.87264254717;6434.613923164625;6886.24251332353;6887.6556172191695;6950.200726916419;6985.266547012592;6990.6155161466095;6765.594064356154;6801;6804.251532331439;6829.829254268633;6850.897236541456;6319.936800631981;6347.904781428282;6366.140571022899;6367.713452894631;6386.648734319657;7111.751088711973;7142.071530700976;7143.535670181422;7156.962240475102;7161.856762864713;6646.501512386591;6757.729690812411;6813.1142951415995;6856.760013399507;6881.518293719391;6732.394084532416;6821.249662537117;6872;6914.0666010089;7010.824729381806;6821.55659882116;6822.8635427292165;6836.38472537474;6865.897011544831;6868.484863635247;6743.797686069426;6842.973553966945;6850.280720524373;6854.588724676535;6860.965695171492;5011.473795251446;5011.84964451067;5012.7994880205115;5038.697678139323;5045.974770126126;4503.977480112579;4553.180427523078;4587.495375508692;4604.631629469702;4624.953750462452;6199.473044791153;6280.968595157086;6338.112664227012;6354.3010268870385;6368.4586810121655;6807.625580593115;6807.693653785592;6822.3859852613505;6825.1809782825385;6833.043373927654;6297.748090076438;6307.716152773136;6312.084747711556;6322.936770632326;6388.425041746265;5131.7177555234075;5545.916811247835;5554.055810512223;5610.13042978339;5628.155776633538;7118.430525557943;7196.172440169343;7226.92773072273;7232.602206878567;7255.782326530212;6738.561993470409;6759.5606285591275;6798.966005169942;6881.243063263037;6892.448604111759;7025.437964962893;7117.644117794193;7117.822054448473;7130.108736407949;7232.349088582053;6799.694013769294;6817.863642727217;6839.829004274933;6844;6844.863102737818;6830.93169068303;6902.378785909293;6945.68744406513;6952.44380449573;6955.6869940851775;6666.400023997863;6694.799156025327;6785.830354241183;6791.524593278621;6801.795946121624;6658.83352916181;6674.632895190811;6699.296573859675;6782.796516104525;6786.796396108125;6560.3111673275525;6635.104260924713;6650.168728908887;6715.865682686416;6759.898601521079;6741.865162696817;6766.729330826909;6771.187457505131;6796.626185559841;6800.965995169992;6519.7392104315295;6596.439302659136;6617.338266173537;6623.039659249478;6628.171478565179 05:57:57 INFO - PID 4585 | |1;ext.html;901.7475106970047;917.3945196170529;955.130830943841;974.2692980264801;978.7014960437068;40181;41172;41254.38118428218;41291.174176516455;41318;38517.80741096291;38723.22553548928;38801.41797873027;38848.611513884855;39142.41286380707;7174.605396703179;7274.127104747411;7292.19785823559;7293.452991025668;7295.051643286365;7153.570785752845;7244.384227340683;7244.818879528001;7264.309890560415;7272.8181795455275;7259.927400726005;7279.090113735783;7279.963600181992;7280.563166210018;7291.526050806707;7176.8205794855285;7187.496875218737;7214.134303883541;7223.89164162538;7272.309130632581;6620.073189753439;6672.165979252593;6673.799786006428;6676.899846502306;6681.131452911139;33811.15472113192;33978.66021339804;34016.31967360639;34108.317833643436;34135.14662133442;3546.2730140321432;3573.624769399202;3574.195805943668;3574.7140228781636;3574.857005719768;28219.435611287863;28278.575821362698;28285.434291314265;28323.85838070817;28326.716732832614;4816.686915350491;4850.5877000455;4862.124817532843;4893.8776530586665;4916.016796640686;213489;213555;214162;214394.92802536042;214639;23328.300150995496;23371.065157393514;23375.7662423377;23409.41476463068;48190;50652;50702;50715;50810;50847.23729144066;15487;15733.213339332988;16580.75128873068;16637.750433743502;16751.497455076365;12886.742265154831;12956.676083097998;12959.352032398343;12963.546275880299;12988.285644289655;13892.305384730926;13975.440982360591;14023.387310459224;14106.858931410554;14232.359543820552;5606.831795046155;5661.943380566224;5786.103154011135;5790.710464476843;5860.648361098262;1074.3500182389698;1092.082650573522;1093.2729734726477;1097.2538673701958;1111.922165448427;24664.13675521348;24871.253862384157;25018.874905625355;25114.623280650805;25188.496230075663;1199.7660456211129;1201.4413297816557;1205.6925484001524;1214.9028077753935;1216.9087318451152;13071.542496012595;13337.799933001013;13425.93287033578;13459.663508412368;13492.662683432796;274248;277402;277676;278240;278332;47061.29408058882;52309;52545;52742;53429.465705343224;1458.875995540391;1508.924553772307;1518.1270769307691;1530.1584128729155;1534.4706076403622;29280;29563.408731824813;29692;29713.554296685135;30004.399912002074;35633.10917226986;38766.2246755069;39170.80414597909;39279.41080883846;39314.60685393224;231615;231730;233015;234316;234953;34002.14994625154;34445.13887152841;34467.655323446445;34489.482657759654;34490.82754586211;43322.78338608287;43570.78214608907;43705;43775.78112109419;43859.561404385546;32716.83641581872;33270.83364583162;33687.494687579216;33778.15554611154;33861.830690846386;32358;33303.16742081467;33358.33283334368;33951.320973580885;34005.82997084999;37751.62248377591;37994.81002594969;38162.236755265294;38207.808960955015;38367.232655347296;32173.839130804197;32453.35093298168;32547.34905301928;32644.34711305808;33027.174320642174;24232;25044.62433063469;25427;25691.35771605725;25844.224673259832 05:57:57 INFO - PID 4585 | |2;jquery.html;595.7527626035196;601.4677010845401;601.9759209631615;614.5053232148119;619.6313193649779;22918.885405572968;23202.88398558009;23493.882530587343;23513.412164695892;23549.29352119437;26760;27147.592786108224;27195.45609087817;27311.86344068277;27342;6404.743810247584;6552;6552.148220731298;6557.245916719567;6568.376004279586;6392.840178995516;6557.114789503427;6646.634435106067;6649.401553860152;6649.700763465656;6604.438622717074;6614.801555953305;6622.37087476689;6622.834429139262;6623.172103487064;6605.075289459432;6610.107635469199;6625;6628.569143005713;6642.933570664304;6185.690715464209;6194.473469755077;6196.473299769525;6213.5029197664535;6224.159738435344;30577.235569110726;30663.233419164477;31156.688433115607;31830.681693183004;31917.680823191702;2267.3764714703425;2323.8605683659034;2325.755795641467;2326.1974618756503;2330.265966220635;19968.201271949103;20489.38531844047;20965.16139354424;21133.8943305284;21187.258445954318;2534.3157347516253;2540.8221424500107;2582.728813474577;2590.0416845767186;2590.870456477169;156008;157835;159405.20297398555;159477;159504.99999999884;15843.920780396023;15878.9206053969;16503.422380216874;16602.25289861935;16656.83343166577;25684.871575642002;25701.742982570308;25882;25901.8704906478;25977.090801821847;10554.625209327993;10841.620543280947;10888.29226100301;10919.508622112024;11107.888921110847;8849.469031858109;9987.700368988943;10032.448215348226;10123.291369604058;10166.644167454104;8365.554656355847;9756.414615123116;9774.413535187769;9795.069468400634;9835.508224588742;2818.3376906426975;2868.612737280482;2961;2992.760579153706;3108.891188808381;1019.954102065394;1035.3684252605904;1042.2599954032721;1050.7110544600143;1054.1408751867205;21270.680939785914;21686.13255469795;22277;22307;22478.438039048826;1069.844872493484;1084.9132069434427;1115.576081089181;1131.5530365505745;1136.9204155709187;11780.70548236301;12147;12289.385530723428;12334.938325308316;12336.691582710504;599172;607420;623550;624779;627027;126931;133531.33234333765;136341.3182934099;141794.29102854626;142246;1244.9315287659085;1274.7769140400392;1304.504288370432;1309.9869001309864;1319.5909268126911;22923.426914327276;23643.290701278987;24040.39899002539;24180.395490112183;24205.51588968246;66090.33909660841;66929;67116.328836711;67267;69356.30643693499;87565;87629.56185219034;87845;88383.79040523781;88492;13409.128406653535;13851.376688049264;15448.922755386151;15467.922660386626;16089.356425742839;25128.874355628104;25384.492310154063;25569;25584.360390990376;25722.871385642953;19491.220351185795;19960.90019549893;20078.89960550246;20979.58040839144;21034.47413814667;17724.734128987817;18132;18361.449156525327;18442.446726598224;18816.906469434132;20389.49026274355;20605.484862878548;20669.276575319793;20862.26982055621;20939.8953005234;15379.76930346068;15686.921565392557;16087.356505739639;16130.274137664068;16194.757078643594;20661.896690516453;20755.169793208708;20803;20831.479213019797;21018.789812102295 05:57:57 INFO - PID 4585 | |3;mootools.html;1394.1356359057384;1455.1487379882767;1459.9270036498176;1467.8678918897297;1473.0866862545224;16365.263563139657;17055.488335349928;17064.48806535803;17069.146542672846;17098.572535686613;16206.918965405157;17444.56388590286;17527;17548.736768948445;17558;2727.3454370950926;2781.860906954644;2784.0812531864535;2785.428987057648;2791.9720802792017;2682.275785537913;2688.46230753849;2746.8489233092173;2787.7212278772163;2789.4142230131597;2721;2727.7817774577984;2746.615473833665;2751.697313295536;2754.256350785287;2583.0313632387856;2605.0882191233104;2622.278873309836;2685.6508653875067;2697.1908427471776;2679.6784385873625;2716.7419095185924;2722.7413395727376;2724.9182524524294;2728.4133911209187;16307.184640768033;16535.25591348392;16554.17229138538;16634.916825415796;16642.251098700588;8031.759047228593;8303.4602750821;8334.708285209988;8344.332453403713;8345.54099524526;5168.22476628505;5391.73041347931;5462.535684466825;5465.9726701366635;5483.095289277265;2084.27050532314;2124.415785658941;2130.5632345369318;2163.8485306028583;2200.020990659157;30884.691153088406;31167.22081947947;31177.37645247105;31179.220519487193;31183;6432.388923052303;6613.437857782046;6633.1045308882685;6847.863042739117;6885.1049363582415;18726.719099213522;18843;18875.244990200237;18911.810881891004;18931.958742269308;8087.0295564532635;8178.959105204436;8222.301104406193;8241.093479717227;8241.752747417588;7524.849503010018;7560.319571238615;7584.62076896153;7661.042369703787;7679.1936846631415;5225.16397376418;5342.358916929993;5489.725513724298;5619.494245517923;5721.370649228582;1658.6268089679968;1675.3717355991503;1675.5392267126638;1697.041171737964;1725.7583938248656;950.9714708558754;966.6423423333412;969.060011788564;978.3542861711379;993.7565296502403;9670.468124253093;9763.267754918268;10168.237382196217;10362;10404.167666586807;1040.953157107932;1067.258255512427;1069.6095924987324;1071.5231721883843;1081.4754843900703;6267.871783078998;6339.968300158562;6344.587601805868;6383.616982981036;6390.3894299720505;24357.147499837774;24841.378965525644;25697.229083127535;26051.869740651175;26163;24117.15589954343;25155.496890062095;25534.489310213692;25576.616350754754;25689.8715506425;12153.453094610764;12238.082143839247;12466.937665311616;12482.43829027696;12545;9239.307051970995;9240.815183696423;9324.580393882427;9333.85999210026;9657.372270802376;20719.58560828745;21026.47433814167;21097;21640;21788.346349609536;21816.67274990908;21868.125274988823;21873.234436794635;22024.339269821932;22202.44493887601;12125.636230913087;12496.312702801433;12611.43248553799;12615.558455454015;12624.74750505003;13325.733485330433;14935.327910244283;15546.611334716723;15750.527484175493;15773.763393549336;12925.741485170432;13015.869841301466;13147.474101035852;13331.66670833237;13336.666583335495;12078.39608019578;12256.571020014257;12460.314682692539;12494.750104998031;12698.936505317415;10330.276880618285;11005.61480348184;11128;11134.610288639858;11154.832677510007;8155.347572194091;8196.262336389753;8268.09051004401;8291.917080829115;8329.292010179202;8248;8280.420370574002;8316.251537361666;8324.875126873223;8397 05:57:57 INFO - PID 4585 | |4;prototype.html;541.5992165797309;550.7576666266842;572.6449601247227;574.2362657665304;575.4102045403461;6011.308699499559;6142.815715528535;6162.568620196588;6267.3732626737365;6283.371662833714;6085.330613632497;6122.387761223876;6144.53915956304;6151.661658608775;6153.35389784073;4893.14369985253;4928.1868491698915;4948.8267910623135;4952.999999999982;4956.553910148086;4920.97539512302;4938.925916111261;4964.776585053663;5017.523335283142;5045.798168073273;4975.4527002029745;4990.658127429142;5005.799768009293;5010.974945125287;5028.421731500869;4948.307236986825;4973.776180071905;4986.177280748672;4990.1516742153735;5005.924911126318;4499.145162419162;4513.954860451419;4541.613962813165;4571.542845715435;4576.565226303496;6180.84547886302;6189.876202475925;6205.472534834545;6215.87568248637;6301.369863013708;5811.651300921916;5848.912266315966;5866.677332746697;5875.236219291507;5923.437273459014;6628.5691430056895;6646.26891041985;6661.666916654148;6666.866662666768;6671.86656266872;5021.949780502221;5041.823536176216;5078.492150784892;5087.389513258396;5099.08216521026;6726.293739157367;6842.315768423118;6885.2770459101575;6938.27148149437;6989.580625162506;5145.742712864417;5150.768215430315;5158.226266060121;5164.9741751291;5172.974135129375;5244.947550524522;5250.842474725764;5266.104762190437;5282.339707536558;5288.418273989858;5720.77116915327;5721.027425337619;5747.655140691572;5778.624389414675;5795.333536643256;6551.44312733423;6563.04835798816;6577.3422657733845;6590.275069742324;6628.5691430056895;1771.0878897367866;1775.6359946210996;1787.7765279340083;1805.3049575913105;1810.646923849863;1204.6332046332047;1260.8423947006625;1274.3564499927663;1283.6213317071486;1297.4874924404808;6045.939540604538;6139.324674285825;6154.815355539252;6205.503559715212;6237.812865614039;6679.76620818269;6680.498962577826;6699.665016749143;6705;6712.496562757813;5868.530517558585;6007.219061521974;6072.939270607326;6118.265808103056;6160.1375807387;3446.965530344715;3470.455647237006;3473.2706131712116;3496.9334353022573;3509.12271932017;6833.726650934006;6877.58734475933;6886.965565172242;6977.860442791116;6979.685914133876;6854.224039264106;6859;6912.516123871382;7003.789886303419;7027.4378049756915;6983.511154219156;6991.755288564876;7009.1589009319205;7010.088688470568;7022.859542809013;6610.405063544112;6645.468362530889;6699.5310328276555;6699.7990060296315;6729.764458243938;6655.866882662416;6669.5664781790965;6699.9665001674675;6708.798736037927;6735.797926062226;6924.307569243036;6967.965160174167;7003.299670032956;7014.7022800782015;7033.859322813412;5132.30713853625;5135.897282054413;5159.922601160911;5168.508991645787;5169.638125331191;6382.744690212339;6535.379138981789;6597.50518711089;6606.867862642816;6637.303083176197;6466.288708241996;6493.610383377012;6497.5126865484335;6519.576227545194;6537.8692426152165;6410.326915673787;6442.677866106582;6475.190601174853;6483.513736469878;6532.150820393318;6437.903431448438;6465.321141280097;6499.38255865692;6541.182352205974;6552.312007239362;6484.221893372825;6484.351564843478;6561.80314590563;6597.175353080865;6598.142241508765;6377.4579160771855;6401.519886008475;6420.486361091008;6424.4986482366285;6452.838679033061 05:57:57 INFO - PID 4585 | |5;yui.html;955.2549011770822;984.7587341101429;1009.4498498318418;1016.0601443664608;1016.4714348538764;19975.30086446973;20518.38444846653;20716.27493037744;20723.378298651027;23451.5309693806;22601.321960341174;22931.541369172606;22976.310710678707;22989.080436782508;23013.539729205408;1033.1373303291741;1061.3101484035362;1061.5647584490362;1061.7027232374908;1063.0220197418355;1032.7211652853725;1070.2026989892502;1074.1782536359692;1083.0847933496184;1083.5990683447135;1127.334872425273;1128.90968722502;1130.604288499023;1130.864296284447;1131.592626654408;1122.4892673833426;1125.6341688951084;1128.6783266768932;1128.7065363005636;1130.028175768838;832.2967092806568;833.8624127019035;834.7495751274594;834.8205135895751;835.1856939483954;18880.905595471933;18986.05069746507;19022.714659279984;20273.189072437086;21118.260860869796;22752.886235568883;22932.19737309203;23448.179313724107;23565;23740.762592374027;17635.382761603283;18006.729899051526;18229.997350145735;18493.167807448695;18649.25402983879;3921.6470517653547;3943.2310699413624;3954.8022598869943;3955.9406608900604;3958.2281455116263;142320.01879934256;143455;143685.2815735925;144980;147824;16693.165341732863;16998.83001169997;17604.647907041788;17669.469915902544;17687.73468397975;32608.184795380304;33856.32287354239;33933.83033084868;33959;34122;9246.214071803837;9368.203702685349;9373.531323433801;9380.624775009059;9392;4790.257510085942;4875.268709693503;4876.292937524039;4877.268409738496;4880.072786170616;5586.441355864381;5723.971380143073;5724.971375143181;5730.312362516442;5755.85610359736;1067.3115840282974;1090.7273181704575;1106.4744246483017;1106.6071544601712;1107.778444311141;707.5153519838824;725.3508110241304;731.3929438565978;732.0739264829995;747.9139898911695;12668.556600518938;12671.556495522613;12720.236785792697;13093.934530327288;13211.895204626904;646.5732616473199;654.3423859021748;662.2483481248818;666.8299583606247;670.4535803320279;6377.3303803100935;6379.266384365765;6440.4847612190915;6456.612603243821;6486.4486518646445;135356;136297.3185134068;136657.33986209694;137822;140214;120285;121858;124940;124974;126045.36977315055;99290;99878;101157.49421252847;101252.49373753232;101256.49371753242;12054;12068.818967715315;12160.878391215974;12262.26426414418;12576.434060467484;50049.49950500594;51066.48933510618;52208.47791522036;52302;54777.726111369186;86709.56645216733;87046.56476717576;88291.55854220944;88796;94483;18373.72439413383;18437.87964384113;18543.907280464053;18708.158132884324;18780.154893029572;19675.508112297306;20002.799972000095;20045.79954200439;21077;21464.678029829876;20829.479263018547;21405.78594214038;21750.564988700455;21796.89101554482;21817.56364872662;21130.260440884496;21264.043118060035;21695.674564881854;21745;21826.56346873022;20174.49563760859;20227.59544809125;20326.491837703583;20560.58878822445;20599.897000514902;14549.563513094625;14649.70700585961;14839.851601483848;14890.627734306729;14930.477433289783;15293.770593440884;15566.9221653891;15969.121698306704;16275.755863661818;16442.671146576762 05:57:57 INFO - PID 4585 | __end_tp_report 05:57:57 INFO - PID 4585 | __start_cc_report 05:57:57 INFO - PID 4585 | _x_x_mozilla_cycle_collect,343 05:57:57 INFO - PID 4585 | __end_cc_report 05:57:57 INFO - PID 4585 | __startTimestamp1504789077458__endTimestamp 05:57:57 INFO - PID 4585 | 05:57:57 INFO - PID 4585 | ------- Summary: start ------- 05:57:57 INFO - PID 4585 | Number of tests: 6 05:57:57 INFO - PID 4585 | 05:57:57 INFO - PID 4585 | [#0] dojo.html Cycles:165 Average:6342.40 Median:6646.50 stddev:757.44 (11.4%) stddev-sans-first:733.90 05:57:57 INFO - PID 4585 | Values: 3840.8 3886.4 3887.3 3894.7 3903.4 6268.0 6403.7 6466.5 6481.0 6502.7 6300.3 6406.2 6416.5 6436.3 6437.8 5663.5 5666.7 5677.0 5711.5 5725.9 5725.5 5727.0 5732.5 5779.3 5797.4 5770.1 5806.0 5812.3 5818.3 5851.5 5697.1 5722.9 5818.2 5824.7 5831.9 5511.6 5657.1 5669.5 5672.0 5813.6 6337.1 6347.8 6349.4 6367.9 6434.6 6886.2 6887.7 6950.2 6985.3 6990.6 6765.6 6801.0 6804.3 6829.8 6850.9 6319.9 6347.9 6366.1 6367.7 6386.6 7111.8 7142.1 7143.5 7157.0 7161.9 6646.5 6757.7 6813.1 6856.8 6881.5 6732.4 6821.2 6872.0 6914.1 7010.8 6821.6 6822.9 6836.4 6865.9 6868.5 6743.8 6843.0 6850.3 6854.6 6861.0 5011.5 5011.8 5012.8 5038.7 5046.0 4504.0 4553.2 4587.5 4604.6 4625.0 6199.5 6281.0 6338.1 6354.3 6368.5 6807.6 6807.7 6822.4 6825.2 6833.0 6297.7 6307.7 6312.1 6322.9 6388.4 5131.7 5545.9 5554.1 5610.1 5628.2 7118.4 7196.2 7226.9 7232.6 7255.8 6738.6 6759.6 6799.0 6881.2 6892.4 7025.4 7117.6 7117.8 7130.1 7232.3 6799.7 6817.9 6839.8 6844.0 6844.9 6830.9 6902.4 6945.7 6952.4 6955.7 6666.4 6694.8 6785.8 6791.5 6801.8 6658.8 6674.6 6699.3 6782.8 6786.8 6560.3 6635.1 6650.2 6715.9 6759.9 6741.9 6766.7 6771.2 6796.6 6801.0 6519.7 6596.4 6617.3 6623.0 6628.2 05:57:57 INFO - PID 4585 | 05:57:57 INFO - PID 4585 | [#1] ext.html Cycles:180 Average:40062.16 Median:34003.99 stddev:63224.21 (185.9%) stddev-sans-first:63333.20 05:57:57 INFO - PID 4585 | Values: 901.7 917.4 955.1 974.3 978.7 40181.0 41172.0 41254.4 41291.2 41318.0 38517.8 38723.2 38801.4 38848.6 39142.4 7174.6 7274.1 7292.2 7293.5 7295.1 7153.6 7244.4 7244.8 7264.3 7272.8 7259.9 7279.1 7280.0 7280.6 7291.5 7176.8 7187.5 7214.1 7223.9 7272.3 6620.1 6672.2 6673.8 6676.9 6681.1 33811.2 33978.7 34016.3 34108.3 34135.1 3546.3 3573.6 3574.2 3574.7 3574.9 28219.4 28278.6 28285.4 28323.9 28326.7 4816.7 4850.6 4862.1 4893.9 4916.0 213489.0 213555.0 214162.0 214394.9 214639.0 23328.3 23371.1 23375.8 23409.4 48190.0 50652.0 50702.0 50715.0 50810.0 50847.2 15487.0 15733.2 16580.8 16637.8 16751.5 12886.7 12956.7 12959.4 12963.5 12988.3 13892.3 13975.4 14023.4 14106.9 14232.4 5606.8 5661.9 5786.1 5790.7 5860.6 1074.4 1092.1 1093.3 1097.3 1111.9 24664.1 24871.3 25018.9 25114.6 25188.5 1199.8 1201.4 1205.7 1214.9 1216.9 13071.5 13337.8 13425.9 13459.7 13492.7 274248.0 277402.0 277676.0 278240.0 278332.0 47061.3 52309.0 52545.0 52742.0 53429.5 1458.9 1508.9 1518.1 1530.2 1534.5 29280.0 29563.4 29692.0 29713.6 30004.4 35633.1 38766.2 39170.8 39279.4 39314.6 231615.0 231730.0 233015.0 234316.0 234953.0 34002.1 34445.1 34467.7 34489.5 34490.8 43322.8 43570.8 43705.0 43775.8 43859.6 32716.8 33270.8 33687.5 33778.2 33861.8 32358.0 33303.2 33358.3 33951.3 34005.8 37751.6 37994.8 38162.2 38207.8 38367.2 32173.8 32453.4 32547.3 32644.3 33027.2 24232.0 25044.6 25427.0 25691.4 25844.2 05:57:57 INFO - PID 4585 | 05:57:57 INFO - PID 4585 | [#2] jquery.html Cycles:180 Average:41107.68 Median:12912.07 stddev:103470.47 (801.3%) stddev-sans-first:103716.02 05:57:57 INFO - PID 4585 | Values: 595.8 601.5 602.0 614.5 619.6 22918.9 23202.9 23493.9 23513.4 23549.3 26760.0 27147.6 27195.5 27311.9 27342.0 6404.7 6552.0 6552.1 6557.2 6568.4 6392.8 6557.1 6646.6 6649.4 6649.7 6604.4 6614.8 6622.4 6622.8 6623.2 6605.1 6610.1 6625.0 6628.6 6642.9 6185.7 6194.5 6196.5 6213.5 6224.2 30577.2 30663.2 31156.7 31830.7 31917.7 2267.4 2323.9 2325.8 2326.2 2330.3 19968.2 20489.4 20965.2 21133.9 21187.3 2534.3 2540.8 2582.7 2590.0 2590.9 156008.0 157835.0 159405.2 159477.0 159505.0 15843.9 15878.9 16503.4 16602.3 16656.8 25684.9 25701.7 25882.0 25901.9 25977.1 10554.6 10841.6 10888.3 10919.5 11107.9 8849.5 9987.7 10032.4 10123.3 10166.6 8365.6 9756.4 9774.4 9795.1 9835.5 2818.3 2868.6 2961.0 2992.8 3108.9 1020.0 1035.4 1042.3 1050.7 1054.1 21270.7 21686.1 22277.0 22307.0 22478.4 1069.8 1084.9 1115.6 1131.6 1136.9 11780.7 12147.0 12289.4 12334.9 12336.7 599172.0 607420.0 623550.0 624779.0 627027.0 126931.0 133531.3 136341.3 141794.3 142246.0 1244.9 1274.8 1304.5 1310.0 1319.6 22923.4 23643.3 24040.4 24180.4 24205.5 66090.3 66929.0 67116.3 67267.0 69356.3 87565.0 87629.6 87845.0 88383.8 88492.0 13409.1 13851.4 15448.9 15467.9 16089.4 25128.9 25384.5 25569.0 25584.4 25722.9 19491.2 19960.9 20078.9 20979.6 21034.5 17724.7 18132.0 18361.4 18442.4 18816.9 20389.5 20605.5 20669.3 20862.3 20939.9 15379.8 15686.9 16087.4 16130.3 16194.8 20661.9 20755.2 20803.0 20831.5 21018.8 05:57:57 INFO - PID 4585 | 05:57:57 INFO - PID 4585 | [#3] mootools.html Cycles:180 Average:10440.85 Median:14140.13 stddev:7787.68 (55.1%) stddev-sans-first:7779.87 05:57:57 INFO - PID 4585 | Values: 1394.1 1455.1 1459.9 1467.9 1473.1 16365.3 17055.5 17064.5 17069.1 17098.6 16206.9 17444.6 17527.0 17548.7 17558.0 2727.3 2781.9 2784.1 2785.4 2792.0 2682.3 2688.5 2746.8 2787.7 2789.4 2721.0 2727.8 2746.6 2751.7 2754.3 2583.0 2605.1 2622.3 2685.7 2697.2 2679.7 2716.7 2722.7 2724.9 2728.4 16307.2 16535.3 16554.2 16634.9 16642.3 8031.8 8303.5 8334.7 8344.3 8345.5 5168.2 5391.7 5462.5 5466.0 5483.1 2084.3 2124.4 2130.6 2163.8 2200.0 30884.7 31167.2 31177.4 31179.2 31183.0 6432.4 6613.4 6633.1 6847.9 6885.1 18726.7 18843.0 18875.2 18911.8 18932.0 8087.0 8179.0 8222.3 8241.1 8241.8 7524.8 7560.3 7584.6 7661.0 7679.2 5225.2 5342.4 5489.7 5619.5 5721.4 1658.6 1675.4 1675.5 1697.0 1725.8 951.0 966.6 969.1 978.4 993.8 9670.5 9763.3 10168.2 10362.0 10404.2 1041.0 1067.3 1069.6 1071.5 1081.5 6267.9 6340.0 6344.6 6383.6 6390.4 24357.1 24841.4 25697.2 26051.9 26163.0 24117.2 25155.5 25534.5 25576.6 25689.9 12153.5 12238.1 12466.9 12482.4 12545.0 9239.3 9240.8 9324.6 9333.9 9657.4 20719.6 21026.5 21097.0 21640.0 21788.3 21816.7 21868.1 21873.2 22024.3 22202.4 12125.6 12496.3 12611.4 12615.6 12624.7 13325.7 14935.3 15546.6 15750.5 15773.8 12925.7 13015.9 13147.5 13331.7 13336.7 12078.4 12256.6 12460.3 12494.8 12698.9 10330.3 11005.6 11128.0 11134.6 11154.8 8155.3 8196.3 8268.1 8291.9 8329.3 8248.0 8280.4 8316.3 8324.9 8397.0 05:57:57 INFO - PID 4585 | 05:57:57 INFO - PID 4585 | [#4] prototype.html Cycles:180 Average:5597.77 Median:6171.71 stddev:1566.35 (25.4%) stddev-sans-first:1524.08 05:57:57 INFO - PID 4585 | Values: 541.6 550.8 572.6 574.2 575.4 6011.3 6142.8 6162.6 6267.4 6283.4 6085.3 6122.4 6144.5 6151.7 6153.4 4893.1 4928.2 4948.8 4953.0 4956.6 4921.0 4938.9 4964.8 5017.5 5045.8 4975.5 4990.7 5005.8 5011.0 5028.4 4948.3 4973.8 4986.2 4990.2 5005.9 4499.1 4514.0 4541.6 4571.5 4576.6 6180.8 6189.9 6205.5 6215.9 6301.4 5811.7 5848.9 5866.7 5875.2 5923.4 6628.6 6646.3 6661.7 6666.9 6671.9 5021.9 5041.8 5078.5 5087.4 5099.1 6726.3 6842.3 6885.3 6938.3 6989.6 5145.7 5150.8 5158.2 5165.0 5173.0 5244.9 5250.8 5266.1 5282.3 5288.4 5720.8 5721.0 5747.7 5778.6 5795.3 6551.4 6563.0 6577.3 6590.3 6628.6 1771.1 1775.6 1787.8 1805.3 1810.6 1204.6 1260.8 1274.4 1283.6 1297.5 6045.9 6139.3 6154.8 6205.5 6237.8 6679.8 6680.5 6699.7 6705.0 6712.5 5868.5 6007.2 6072.9 6118.3 6160.1 3447.0 3470.5 3473.3 3496.9 3509.1 6833.7 6877.6 6887.0 6977.9 6979.7 6854.2 6859.0 6912.5 7003.8 7027.4 6983.5 6991.8 7009.2 7010.1 7022.9 6610.4 6645.5 6699.5 6699.8 6729.8 6655.9 6669.6 6700.0 6708.8 6735.8 6924.3 6968.0 7003.3 7014.7 7033.9 5132.3 5135.9 5159.9 5168.5 5169.6 6382.7 6535.4 6597.5 6606.9 6637.3 6466.3 6493.6 6497.5 6519.6 6537.9 6410.3 6442.7 6475.2 6483.5 6532.2 6437.9 6465.3 6499.4 6541.2 6552.3 6484.2 6484.4 6561.8 6597.2 6598.1 6377.5 6401.5 6420.5 6424.5 6452.8 05:57:57 INFO - PID 4585 | 05:57:57 INFO - PID 4585 | [#5] yui.html Cycles:180 Average:27789.68 Median:20299.84 stddev:39103.20 (192.6%) stddev-sans-first:39160.98 05:57:57 INFO - PID 4585 | Values: 955.3 984.8 1009.4 1016.1 1016.5 19975.3 20518.4 20716.3 20723.4 23451.5 22601.3 22931.5 22976.3 22989.1 23013.5 1033.1 1061.3 1061.6 1061.7 1063.0 1032.7 1070.2 1074.2 1083.1 1083.6 1127.3 1128.9 1130.6 1130.9 1131.6 1122.5 1125.6 1128.7 1128.7 1130.0 832.3 833.9 834.7 834.8 835.2 18880.9 18986.1 19022.7 20273.2 21118.3 22752.9 22932.2 23448.2 23565.0 23740.8 17635.4 18006.7 18230.0 18493.2 18649.3 3921.6 3943.2 3954.8 3955.9 3958.2 142320.0 143455.0 143685.3 144980.0 147824.0 16693.2 16998.8 17604.6 17669.5 17687.7 32608.2 33856.3 33933.8 33959.0 34122.0 9246.2 9368.2 9373.5 9380.6 9392.0 4790.3 4875.3 4876.3 4877.3 4880.1 5586.4 5724.0 5725.0 5730.3 5755.9 1067.3 1090.7 1106.5 1106.6 1107.8 707.5 725.4 731.4 732.1 747.9 12668.6 12671.6 12720.2 13093.9 13211.9 646.6 654.3 662.2 666.8 670.5 6377.3 6379.3 6440.5 6456.6 6486.4 135356.0 136297.3 136657.3 137822.0 140214.0 120285.0 121858.0 124940.0 124974.0 126045.4 99290.0 99878.0 101157.5 101252.5 101256.5 12054.0 12068.8 12160.9 12262.3 12576.4 50049.5 51066.5 52208.5 52302.0 54777.7 86709.6 87046.6 88291.6 88796.0 94483.0 18373.7 18437.9 18543.9 18708.2 18780.2 19675.5 20002.8 20045.8 21077.0 21464.7 20829.5 21405.8 21750.6 21796.9 21817.6 21130.3 21264.0 21695.7 21745.0 21826.6 20174.5 20227.6 20326.5 20560.6 20599.9 14549.6 14649.7 14839.9 14890.6 14930.5 15293.8 15566.9 15969.1 16275.8 16442.7 05:57:57 INFO - PID 4585 | -------- Summary: end -------- 05:57:57 INFO - PID 4585 | 05:57:58 INFO - TEST-INFO | 4585: exit 0 05:57:58 INFO - TEST-OK | dromaeo_css | took 1107741ms 05:57:58 INFO - TEST-START | kraken 05:57:58 INFO - Initialising browser for kraken test... 05:57:58 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:34151/getInfo.html -profile /tmp/tmp0MV2Hv/profile 05:57:58 INFO - TEST-INFO | started process 4973 (/builds/slave/test/build/application/firefox/firefox http://localhost:34151/getInfo.html) 05:58:03 INFO - TEST-INFO | 4973: exit 0 05:58:03 INFO - Browser initialized. 05:58:03 INFO - Running cycle 1/1 for kraken test... 05:58:03 INFO - Using env: {'DISPLAY': ':0', 05:58:03 INFO - 'HOME': '/home/cltbld', 05:58:03 INFO - 'JSGC_DISABLE_POISONING': '1', 05:58:03 INFO - 'LANG': 'en_US.UTF-8', 05:58:03 INFO - 'LANGUAGE': 'en_US:en', 05:58:03 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 05:58:03 INFO - 'LOGNAME': 'cltbld', 05:58:03 INFO - 'MAIL': '/var/mail/cltbld', 05:58:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:58:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:58:03 INFO - 'MOZ_CRASHREPORTER': '1', 05:58:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:03 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 05:58:03 INFO - 'MOZ_NO_REMOTE': '1', 05:58:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:58:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:03 INFO - 'NO_EM_RESTART': '1', 05:58:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:03 INFO - 'PWD': '/builds/slave/test', 05:58:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:58:03 INFO - 'RUST_BACKTRACE': 'full', 05:58:03 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 05:58:03 INFO - 'SHELL': '/bin/bash', 05:58:03 INFO - 'SHLVL': '1', 05:58:03 INFO - 'TERM': 'linux', 05:58:03 INFO - 'TMOUT': '86400', 05:58:03 INFO - 'USER': 'cltbld', 05:58:03 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1504787899.862163-2100156443', 05:58:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:03 INFO - '_': '/tools/buildbot/bin/python'} 05:58:03 INFO - TEST-INFO | started process 5176 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0MV2Hv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:58:04 INFO - PID 5176 | 05:58:04 INFO - PID 5176 | (/builds/slave/test/build/application/firefox/firefox:5227): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 05:58:04 INFO - PID 5176 | 05:58:14 INFO - PID 5176 | RSS: Main: 164052992 05:58:14 INFO - PID 5176 | 05:58:17 INFO - PID 5176 | Cycle 1(1): loaded http://localhost:34151/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34151/tests/kraken/driver.html?testName=audio-beat-detection) 05:58:18 INFO - PID 5176 | RSS: Main: 170254336 05:58:18 INFO - PID 5176 | 05:58:20 INFO - PID 5176 | Cycle 1(1): loaded http://localhost:34151/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34151/tests/kraken/driver.html?testName=audio-dft) 05:58:21 INFO - PID 5176 | RSS: Main: 170541056 05:58:21 INFO - PID 5176 | 05:58:24 INFO - PID 5176 | Cycle 1(1): loaded http://localhost:34151/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34151/tests/kraken/driver.html?testName=audio-fft) 05:58:24 INFO - PID 5176 | RSS: Main: 164487168 05:58:24 INFO - PID 5176 | 05:58:27 INFO - PID 5176 | Cycle 1(1): loaded http://localhost:34151/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34151/tests/kraken/driver.html?testName=audio-oscillator) 05:58:27 INFO - PID 5176 | RSS: Main: 166043648 05:58:27 INFO - PID 5176 | 05:58:29 INFO - PID 5176 | Cycle 1(1): loaded http://localhost:34151/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34151/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:58:30 INFO - PID 5176 | RSS: Main: 165888000 05:58:30 INFO - PID 5176 | 05:58:33 INFO - PID 5176 | Cycle 1(1): loaded http://localhost:34151/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34151/tests/kraken/driver.html?testName=imaging-darkroom) 05:58:34 INFO - PID 5176 | RSS: Main: 168353792 05:58:34 INFO - PID 5176 | 05:58:37 INFO - PID 5176 | Cycle 1(1): loaded http://localhost:34151/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34151/tests/kraken/driver.html?testName=imaging-desaturate) 05:58:38 INFO - PID 5176 | RSS: Main: 170934272 05:58:38 INFO - PID 5176 | 05:58:40 INFO - PID 5176 | Cycle 1(1): loaded http://localhost:34151/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34151/tests/kraken/driver.html?testName=json-parse-financial) 05:58:41 INFO - PID 5176 | RSS: Main: 169197568 05:58:41 INFO - PID 5176 | 05:58:42 INFO - PID 5176 | Cycle 1(1): loaded http://localhost:34151/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34151/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:58:43 INFO - PID 5176 | RSS: Main: 168779776 05:58:43 INFO - PID 5176 | 05:58:45 INFO - PID 5176 | Cycle 1(1): loaded http://localhost:34151/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34151/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:58:45 INFO - PID 5176 | RSS: Main: 169623552 05:58:45 INFO - PID 5176 | 05:58:47 INFO - PID 5176 | Cycle 1(1): loaded http://localhost:34151/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34151/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:58:48 INFO - PID 5176 | RSS: Main: 165818368 05:58:48 INFO - PID 5176 | 05:58:50 INFO - PID 5176 | Cycle 1(1): loaded http://localhost:34151/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34151/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:58:51 INFO - PID 5176 | RSS: Main: 166080512 05:58:51 INFO - PID 5176 | 05:58:54 INFO - PID 5176 | Cycle 1(1): loaded http://localhost:34151/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34151/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:58:55 INFO - PID 5176 | RSS: Main: 166379520 05:58:55 INFO - PID 5176 | 05:58:56 INFO - PID 5176 | Cycle 1(1): loaded http://localhost:34151/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34151/tests/kraken/driver.html?testName=ai-astar) 05:58:56 INFO - PID 5176 | RSS: Main: 168128512 05:58:56 INFO - PID 5176 | 05:58:56 INFO - PID 5176 | __start_tp_report 05:58:56 INFO - PID 5176 | _x_x_mozilla_page_load 05:58:56 INFO - PID 5176 | _x_x_mozilla_page_load_details 05:58:56 INFO - PID 5176 | |i|pagename|runs| 05:58:56 INFO - PID 5176 | |0;ai-astar;98;105;96;109;107;105;107;96;105;107 05:58:56 INFO - PID 5176 | |1;audio-beat-detection;133;112;140;170;126;134;147;113;167;112 05:58:56 INFO - PID 5176 | |2;audio-dft;166;164;163;163;162;167;162;161;164;165 05:58:56 INFO - PID 5176 | |3;audio-fft;73;82;78;171;74;74;73;73;153;77 05:58:56 INFO - PID 5176 | |4;audio-oscillator;77;78;123;78;78;79;131;78;78;130 05:58:56 INFO - PID 5176 | |5;imaging-gaussian-blur;114;114;114;114;113;114;113;114;114;114 05:58:56 INFO - PID 5176 | |6;imaging-darkroom;149;155;149;150;149;150;150;151;149;149 05:58:56 INFO - PID 5176 | |7;imaging-desaturate;93;94;93;95;94;94;94;94;95;94 05:58:56 INFO - PID 5176 | |8;json-parse-financial;44;45;44;43;43;43;44;44;43;44 05:58:56 INFO - PID 5176 | |9;json-stringify-tinderbox;37;37;37;37;37;37;37;37;37;37 05:58:56 INFO - PID 5176 | |10;stanford-crypto-aes;72;71;73;73;74;72;73;77;73;72 05:58:56 INFO - PID 5176 | |11;stanford-crypto-ccm;111;109;114;117;117;112;107;117;110;159 05:58:56 INFO - PID 5176 | |12;stanford-crypto-pbkdf2;153;158;158;152;153;154;160;166;153;155 05:58:56 INFO - PID 5176 | |13;stanford-crypto-sha256-iterative;59;61;59;58;59;59;58;59;60;61 05:58:56 INFO - PID 5176 | __end_tp_report 05:58:56 INFO - PID 5176 | __start_cc_report 05:58:56 INFO - PID 5176 | _x_x_mozilla_cycle_collect,885 05:58:56 INFO - PID 5176 | __end_cc_report 05:58:56 INFO - PID 5176 | __startTimestamp1504789136965__endTimestamp 05:58:56 INFO - PID 5176 | 05:58:56 INFO - PID 5176 | ------- Summary: start ------- 05:58:56 INFO - PID 5176 | Number of tests: 14 05:58:56 INFO - PID 5176 | 05:58:56 INFO - PID 5176 | [#0] ai-astar Cycles:10 Average:103.50 Median:108.00 stddev:4.90 (4.5%) stddev-sans-first:4.78 05:58:56 INFO - PID 5176 | Values: 98.0 105.0 96.0 109.0 107.0 105.0 107.0 96.0 105.0 107.0 05:58:56 INFO - PID 5176 | 05:58:56 INFO - PID 5176 | [#1] audio-beat-detection Cycles:10 Average:135.40 Median:137.00 stddev:21.20 (15.5%) stddev-sans-first:22.47 05:58:56 INFO - PID 5176 | Values: 133.0 112.0 140.0 170.0 126.0 134.0 147.0 113.0 167.0 112.0 05:58:56 INFO - PID 5176 | 05:58:56 INFO - PID 5176 | [#2] audio-dft Cycles:10 Average:163.70 Median:164.00 stddev:1.89 (1.2%) stddev-sans-first:1.81 05:58:56 INFO - PID 5176 | Values: 166.0 164.0 163.0 163.0 162.0 167.0 162.0 161.0 164.0 165.0 05:58:56 INFO - PID 5176 | 05:58:56 INFO - PID 5176 | [#3] audio-fft Cycles:10 Average:92.80 Median:74.00 stddev:36.83 (49.8%) stddev-sans-first:38.36 05:58:56 INFO - PID 5176 | Values: 73.0 82.0 78.0 171.0 74.0 74.0 73.0 73.0 153.0 77.0 05:58:56 INFO - PID 5176 | 05:58:56 INFO - PID 5176 | [#4] audio-oscillator Cycles:10 Average:93.00 Median:78.00 stddev:24.24 (31.1%) stddev-sans-first:25.01 05:58:56 INFO - PID 5176 | Values: 77.0 78.0 123.0 78.0 78.0 79.0 131.0 78.0 78.0 130.0 05:58:56 INFO - PID 5176 | 05:58:56 INFO - PID 5176 | [#5] imaging-gaussian-blur Cycles:10 Average:113.80 Median:114.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 05:58:56 INFO - PID 5176 | Values: 114.0 114.0 114.0 114.0 113.0 114.0 113.0 114.0 114.0 114.0 05:58:56 INFO - PID 5176 | 05:58:56 INFO - PID 5176 | [#6] imaging-darkroom Cycles:10 Average:150.10 Median:150.00 stddev:1.85 (1.2%) stddev-sans-first:1.92 05:58:56 INFO - PID 5176 | Values: 149.0 155.0 149.0 150.0 149.0 150.0 150.0 151.0 149.0 149.0 05:58:56 INFO - PID 5176 | 05:58:56 INFO - PID 5176 | [#7] imaging-desaturate Cycles:10 Average:94.00 Median:94.00 stddev:0.67 (0.7%) stddev-sans-first:0.60 05:58:56 INFO - PID 5176 | Values: 93.0 94.0 93.0 95.0 94.0 94.0 94.0 94.0 95.0 94.0 05:58:56 INFO - PID 5176 | 05:58:56 INFO - PID 5176 | [#8] json-parse-financial Cycles:10 Average:43.70 Median:44.00 stddev:0.67 (1.5%) stddev-sans-first:0.71 05:58:56 INFO - PID 5176 | Values: 44.0 45.0 44.0 43.0 43.0 43.0 44.0 44.0 43.0 44.0 05:58:56 INFO - PID 5176 | 05:58:56 INFO - PID 5176 | [#9] json-stringify-tinderbox Cycles:10 Average:37.00 Median:37.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 05:58:56 INFO - PID 5176 | Values: 37.0 37.0 37.0 37.0 37.0 37.0 37.0 37.0 37.0 37.0 05:58:56 INFO - PID 5176 | 05:58:56 INFO - PID 5176 | [#10] stanford-crypto-aes Cycles:10 Average:73.00 Median:73.00 stddev:1.63 (2.2%) stddev-sans-first:1.69 05:58:56 INFO - PID 5176 | Values: 72.0 71.0 73.0 73.0 74.0 72.0 73.0 77.0 73.0 72.0 05:58:56 INFO - PID 5176 | 05:58:56 INFO - PID 5176 | [#11] stanford-crypto-ccm Cycles:10 Average:117.30 Median:115.50 stddev:15.08 (13.1%) stddev-sans-first:15.82 05:58:56 INFO - PID 5176 | Values: 111.0 109.0 114.0 117.0 117.0 112.0 107.0 117.0 110.0 159.0 05:58:56 INFO - PID 5176 | 05:58:56 INFO - PID 5176 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.20 Median:156.50 stddev:4.37 (2.8%) stddev-sans-first:4.48 05:58:56 INFO - PID 5176 | Values: 153.0 158.0 158.0 152.0 153.0 154.0 160.0 166.0 153.0 155.0 05:58:56 INFO - PID 5176 | 05:58:56 INFO - PID 5176 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:59.30 Median:59.00 stddev:1.06 (1.8%) stddev-sans-first:1.12 05:58:56 INFO - PID 5176 | Values: 59.0 61.0 59.0 58.0 59.0 59.0 58.0 59.0 60.0 61.0 05:58:56 INFO - PID 5176 | -------- Summary: end -------- 05:58:56 INFO - PID 5176 | 05:58:57 INFO - PID 5176 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 05:58:57 INFO - TEST-INFO | 5176: exit 0 05:58:57 INFO - TEST-OK | kraken | took 59420ms 05:58:57 INFO - SUITE-END | took 1167s 05:58:57 INFO - Completed test suite (00:19:27) 05:58:57 INFO - javascript benchmark 05:58:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9019.845070253901, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3840.7887566183867, 3886.378179491281, 3887.2614203301364, 3894.7273690841653, 3903.3754599264125, 6267.968660156698, 6403.7438502459845, 6466.450351720104, 6480.967595162024, 6502.707378167982, 6300.30696623371, 6406.199225096863, 6416.486681065515, 6436.292007879129, 6437.806865794022, 5663.546916246691, 5666.660000399979, 5677.034904066319, 5711.485966263035, 5725.942740572604, 5725.513331366838, 5727.0, 5732.541396688276, 5779.335376431723, 5797.36229014808, 5770.134479828039, 5805.970970145143, 5812.3025236971625, 5818.301803783552, 5851.531877449794, 5697.145428185764, 5722.914156287659, 5818.214541036969, 5824.650520968713, 5831.854203644943, 5511.641743286674, 5657.09486482165, 5669.546436285087, 5671.971640141773, 5813.593048486608, 6337.144485494446, 6347.777827776005, 6349.396807303298, 6367.87264254717, 6434.613923164625, 6886.24251332353, 6887.6556172191695, 6950.200726916419, 6985.266547012592, 6990.6155161466095, 6765.594064356154, 6801.0, 6804.251532331439, 6829.829254268633, 6850.897236541456, 6319.936800631981, 6347.904781428282, 6366.140571022899, 6367.713452894631, 6386.648734319657, 7111.751088711973, 7142.071530700976, 7143.535670181422, 7156.962240475102, 7161.856762864713, 6646.501512386591, 6757.729690812411, 6813.1142951415995, 6856.760013399507, 6881.518293719391, 6732.394084532416, 6821.249662537117, 6872.0, 6914.0666010089, 7010.824729381806, 6821.55659882116, 6822.8635427292165, 6836.38472537474, 6865.897011544831, 6868.484863635247, 6743.797686069426, 6842.973553966945, 6850.280720524373, 6854.588724676535, 6860.965695171492, 5011.473795251446, 5011.84964451067, 5012.7994880205115, 5038.697678139323, 5045.974770126126, 4503.977480112579, 4553.180427523078, 4587.495375508692, 4604.631629469702, 4624.953750462452, 6199.473044791153, 6280.968595157086, 6338.112664227012, 6354.3010268870385, 6368.4586810121655, 6807.625580593115, 6807.693653785592, 6822.3859852613505, 6825.1809782825385, 6833.043373927654, 6297.748090076438, 6307.716152773136, 6312.084747711556, 6322.936770632326, 6388.425041746265, 5131.7177555234075, 5545.916811247835, 5554.055810512223, 5610.13042978339, 5628.155776633538, 7118.430525557943, 7196.172440169343, 7226.92773072273, 7232.602206878567, 7255.782326530212, 6738.561993470409, 6759.5606285591275, 6798.966005169942, 6881.243063263037, 6892.448604111759, 7025.437964962893, 7117.644117794193, 7117.822054448473, 7130.108736407949, 7232.349088582053, 6799.694013769294, 6817.863642727217, 6839.829004274933, 6844.0, 6844.863102737818, 6830.93169068303, 6902.378785909293, 6945.68744406513, 6952.44380449573, 6955.6869940851775, 6666.400023997863, 6694.799156025327, 6785.830354241183, 6791.524593278621, 6801.795946121624, 6658.83352916181, 6674.632895190811, 6699.296573859675, 6782.796516104525, 6786.796396108125, 6560.3111673275525, 6635.104260924713, 6650.168728908887, 6715.865682686416, 6759.898601521079, 6741.865162696817, 6766.729330826909, 6771.187457505131, 6796.626185559841, 6800.965995169992, 6519.7392104315295, 6596.439302659136, 6617.338266173537, 6623.039659249478, 6628.171478565179], "value": 6290.445484712964, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [901.7475106970047, 917.3945196170529, 955.130830943841, 974.2692980264801, 978.7014960437068, 40181.0, 41172.0, 41254.38118428218, 41291.174176516455, 41318.0, 38517.80741096291, 38723.22553548928, 38801.41797873027, 38848.611513884855, 39142.41286380707, 7174.605396703179, 7274.127104747411, 7292.19785823559, 7293.452991025668, 7295.051643286365, 7153.570785752845, 7244.384227340683, 7244.818879528001, 7264.309890560415, 7272.8181795455275, 7259.927400726005, 7279.090113735783, 7279.963600181992, 7280.563166210018, 7291.526050806707, 7176.8205794855285, 7187.496875218737, 7214.134303883541, 7223.89164162538, 7272.309130632581, 6620.073189753439, 6672.165979252593, 6673.799786006428, 6676.899846502306, 6681.131452911139, 33811.15472113192, 33978.66021339804, 34016.31967360639, 34108.317833643436, 34135.14662133442, 3546.2730140321432, 3573.624769399202, 3574.195805943668, 3574.7140228781636, 3574.857005719768, 28219.435611287863, 28278.575821362698, 28285.434291314265, 28323.85838070817, 28326.716732832614, 4816.686915350491, 4850.5877000455, 4862.124817532843, 4893.8776530586665, 4916.016796640686, 213489.0, 213555.0, 214162.0, 214394.92802536042, 214639.0, 23328.300150995496, 23371.065157393514, 23375.7662423377, 23409.41476463068, 48190.0, 50652.0, 50702.0, 50715.0, 50810.0, 50847.23729144066, 15487.0, 15733.213339332988, 16580.75128873068, 16637.750433743502, 16751.497455076365, 12886.742265154831, 12956.676083097998, 12959.352032398343, 12963.546275880299, 12988.285644289655, 13892.305384730926, 13975.440982360591, 14023.387310459224, 14106.858931410554, 14232.359543820552, 5606.831795046155, 5661.943380566224, 5786.103154011135, 5790.710464476843, 5860.648361098262, 1074.3500182389698, 1092.082650573522, 1093.2729734726477, 1097.2538673701958, 1111.922165448427, 24664.13675521348, 24871.253862384157, 25018.874905625355, 25114.623280650805, 25188.496230075663, 1199.7660456211129, 1201.4413297816557, 1205.6925484001524, 1214.9028077753935, 1216.9087318451152, 13071.542496012595, 13337.799933001013, 13425.93287033578, 13459.663508412368, 13492.662683432796, 274248.0, 277402.0, 277676.0, 278240.0, 278332.0, 47061.29408058882, 52309.0, 52545.0, 52742.0, 53429.465705343224, 1458.875995540391, 1508.924553772307, 1518.1270769307691, 1530.1584128729155, 1534.4706076403622, 29280.0, 29563.408731824813, 29692.0, 29713.554296685135, 30004.399912002074, 35633.10917226986, 38766.2246755069, 39170.80414597909, 39279.41080883846, 39314.60685393224, 231615.0, 231730.0, 233015.0, 234316.0, 234953.0, 34002.14994625154, 34445.13887152841, 34467.655323446445, 34489.482657759654, 34490.82754586211, 43322.78338608287, 43570.78214608907, 43705.0, 43775.78112109419, 43859.561404385546, 32716.83641581872, 33270.83364583162, 33687.494687579216, 33778.15554611154, 33861.830690846386, 32358.0, 33303.16742081467, 33358.33283334368, 33951.320973580885, 34005.82997084999, 37751.62248377591, 37994.81002594969, 38162.236755265294, 38207.808960955015, 38367.232655347296, 32173.839130804197, 32453.35093298168, 32547.34905301928, 32644.34711305808, 33027.174320642174, 24232.0, 25044.62433063469, 25427.0, 25691.35771605725, 25844.224673259832], "value": 17232.124948741544, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [595.7527626035196, 601.4677010845401, 601.9759209631615, 614.5053232148119, 619.6313193649779, 22918.885405572968, 23202.88398558009, 23493.882530587343, 23513.412164695892, 23549.29352119437, 26760.0, 27147.592786108224, 27195.45609087817, 27311.86344068277, 27342.0, 6404.743810247584, 6552.0, 6552.148220731298, 6557.245916719567, 6568.376004279586, 6392.840178995516, 6557.114789503427, 6646.634435106067, 6649.401553860152, 6649.700763465656, 6604.438622717074, 6614.801555953305, 6622.37087476689, 6622.834429139262, 6623.172103487064, 6605.075289459432, 6610.107635469199, 6625.0, 6628.569143005713, 6642.933570664304, 6185.690715464209, 6194.473469755077, 6196.473299769525, 6213.5029197664535, 6224.159738435344, 30577.235569110726, 30663.233419164477, 31156.688433115607, 31830.681693183004, 31917.680823191702, 2267.3764714703425, 2323.8605683659034, 2325.755795641467, 2326.1974618756503, 2330.265966220635, 19968.201271949103, 20489.38531844047, 20965.16139354424, 21133.8943305284, 21187.258445954318, 2534.3157347516253, 2540.8221424500107, 2582.728813474577, 2590.0416845767186, 2590.870456477169, 156008.0, 157835.0, 159405.20297398555, 159477.0, 159504.99999999884, 15843.920780396023, 15878.9206053969, 16503.422380216874, 16602.25289861935, 16656.83343166577, 25684.871575642002, 25701.742982570308, 25882.0, 25901.8704906478, 25977.090801821847, 10554.625209327993, 10841.620543280947, 10888.29226100301, 10919.508622112024, 11107.888921110847, 8849.469031858109, 9987.700368988943, 10032.448215348226, 10123.291369604058, 10166.644167454104, 8365.554656355847, 9756.414615123116, 9774.413535187769, 9795.069468400634, 9835.508224588742, 2818.3376906426975, 2868.612737280482, 2961.0, 2992.760579153706, 3108.891188808381, 1019.954102065394, 1035.3684252605904, 1042.2599954032721, 1050.7110544600143, 1054.1408751867205, 21270.680939785914, 21686.13255469795, 22277.0, 22307.0, 22478.438039048826, 1069.844872493484, 1084.9132069434427, 1115.576081089181, 1131.5530365505745, 1136.9204155709187, 11780.70548236301, 12147.0, 12289.385530723428, 12334.938325308316, 12336.691582710504, 599172.0, 607420.0, 623550.0, 624779.0, 627027.0, 126931.0, 133531.33234333765, 136341.3182934099, 141794.29102854626, 142246.0, 1244.9315287659085, 1274.7769140400392, 1304.504288370432, 1309.9869001309864, 1319.5909268126911, 22923.426914327276, 23643.290701278987, 24040.39899002539, 24180.395490112183, 24205.51588968246, 66090.33909660841, 66929.0, 67116.328836711, 67267.0, 69356.30643693499, 87565.0, 87629.56185219034, 87845.0, 88383.79040523781, 88492.0, 13409.128406653535, 13851.376688049264, 15448.922755386151, 15467.922660386626, 16089.356425742839, 25128.874355628104, 25384.492310154063, 25569.0, 25584.360390990376, 25722.871385642953, 19491.220351185795, 19960.90019549893, 20078.89960550246, 20979.58040839144, 21034.47413814667, 17724.734128987817, 18132.0, 18361.449156525327, 18442.446726598224, 18816.906469434132, 20389.49026274355, 20605.484862878548, 20669.276575319793, 20862.26982055621, 20939.8953005234, 15379.76930346068, 15686.921565392557, 16087.356505739639, 16130.274137664068, 16194.757078643594, 20661.896690516453, 20755.169793208708, 20803.0, 20831.479213019797, 21018.789812102295], "value": 13079.516979307395, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1394.1356359057384, 1455.1487379882767, 1459.9270036498176, 1467.8678918897297, 1473.0866862545224, 16365.263563139657, 17055.488335349928, 17064.48806535803, 17069.146542672846, 17098.572535686613, 16206.918965405157, 17444.56388590286, 17527.0, 17548.736768948445, 17558.0, 2727.3454370950926, 2781.860906954644, 2784.0812531864535, 2785.428987057648, 2791.9720802792017, 2682.275785537913, 2688.46230753849, 2746.8489233092173, 2787.7212278772163, 2789.4142230131597, 2721.0, 2727.7817774577984, 2746.615473833665, 2751.697313295536, 2754.256350785287, 2583.0313632387856, 2605.0882191233104, 2622.278873309836, 2685.6508653875067, 2697.1908427471776, 2679.6784385873625, 2716.7419095185924, 2722.7413395727376, 2724.9182524524294, 2728.4133911209187, 16307.184640768033, 16535.25591348392, 16554.17229138538, 16634.916825415796, 16642.251098700588, 8031.759047228593, 8303.4602750821, 8334.708285209988, 8344.332453403713, 8345.54099524526, 5168.22476628505, 5391.73041347931, 5462.535684466825, 5465.9726701366635, 5483.095289277265, 2084.27050532314, 2124.415785658941, 2130.5632345369318, 2163.8485306028583, 2200.020990659157, 30884.691153088406, 31167.22081947947, 31177.37645247105, 31179.220519487193, 31183.0, 6432.388923052303, 6613.437857782046, 6633.1045308882685, 6847.863042739117, 6885.1049363582415, 18726.719099213522, 18843.0, 18875.244990200237, 18911.810881891004, 18931.958742269308, 8087.0295564532635, 8178.959105204436, 8222.301104406193, 8241.093479717227, 8241.752747417588, 7524.849503010018, 7560.319571238615, 7584.62076896153, 7661.042369703787, 7679.1936846631415, 5225.16397376418, 5342.358916929993, 5489.725513724298, 5619.494245517923, 5721.370649228582, 1658.6268089679968, 1675.3717355991503, 1675.5392267126638, 1697.041171737964, 1725.7583938248656, 950.9714708558754, 966.6423423333412, 969.060011788564, 978.3542861711379, 993.7565296502403, 9670.468124253093, 9763.267754918268, 10168.237382196217, 10362.0, 10404.167666586807, 1040.953157107932, 1067.258255512427, 1069.6095924987324, 1071.5231721883843, 1081.4754843900703, 6267.871783078998, 6339.968300158562, 6344.587601805868, 6383.616982981036, 6390.3894299720505, 24357.147499837774, 24841.378965525644, 25697.229083127535, 26051.869740651175, 26163.0, 24117.15589954343, 25155.496890062095, 25534.489310213692, 25576.616350754754, 25689.8715506425, 12153.453094610764, 12238.082143839247, 12466.937665311616, 12482.43829027696, 12545.0, 9239.307051970995, 9240.815183696423, 9324.580393882427, 9333.85999210026, 9657.372270802376, 20719.58560828745, 21026.47433814167, 21097.0, 21640.0, 21788.346349609536, 21816.67274990908, 21868.125274988823, 21873.234436794635, 22024.339269821932, 22202.44493887601, 12125.636230913087, 12496.312702801433, 12611.43248553799, 12615.558455454015, 12624.74750505003, 13325.733485330433, 14935.327910244283, 15546.611334716723, 15750.527484175493, 15773.763393549336, 12925.741485170432, 13015.869841301466, 13147.474101035852, 13331.66670833237, 13336.666583335495, 12078.39608019578, 12256.571020014257, 12460.314682692539, 12494.750104998031, 12698.936505317415, 10330.276880618285, 11005.61480348184, 11128.0, 11134.610288639858, 11154.832677510007, 8155.347572194091, 8196.262336389753, 8268.09051004401, 8291.917080829115, 8329.292010179202, 8248.0, 8280.420370574002, 8316.251537361666, 8324.875126873223, 8397.0], "value": 7298.954269913511, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [541.5992165797309, 550.7576666266842, 572.6449601247227, 574.2362657665304, 575.4102045403461, 6011.308699499559, 6142.815715528535, 6162.568620196588, 6267.3732626737365, 6283.371662833714, 6085.330613632497, 6122.387761223876, 6144.53915956304, 6151.661658608775, 6153.35389784073, 4893.14369985253, 4928.1868491698915, 4948.8267910623135, 4952.999999999982, 4956.553910148086, 4920.97539512302, 4938.925916111261, 4964.776585053663, 5017.523335283142, 5045.798168073273, 4975.4527002029745, 4990.658127429142, 5005.799768009293, 5010.974945125287, 5028.421731500869, 4948.307236986825, 4973.776180071905, 4986.177280748672, 4990.1516742153735, 5005.924911126318, 4499.145162419162, 4513.954860451419, 4541.613962813165, 4571.542845715435, 4576.565226303496, 6180.84547886302, 6189.876202475925, 6205.472534834545, 6215.87568248637, 6301.369863013708, 5811.651300921916, 5848.912266315966, 5866.677332746697, 5875.236219291507, 5923.437273459014, 6628.5691430056895, 6646.26891041985, 6661.666916654148, 6666.866662666768, 6671.86656266872, 5021.949780502221, 5041.823536176216, 5078.492150784892, 5087.389513258396, 5099.08216521026, 6726.293739157367, 6842.315768423118, 6885.2770459101575, 6938.27148149437, 6989.580625162506, 5145.742712864417, 5150.768215430315, 5158.226266060121, 5164.9741751291, 5172.974135129375, 5244.947550524522, 5250.842474725764, 5266.104762190437, 5282.339707536558, 5288.418273989858, 5720.77116915327, 5721.027425337619, 5747.655140691572, 5778.624389414675, 5795.333536643256, 6551.44312733423, 6563.04835798816, 6577.3422657733845, 6590.275069742324, 6628.5691430056895, 1771.0878897367866, 1775.6359946210996, 1787.7765279340083, 1805.3049575913105, 1810.646923849863, 1204.6332046332047, 1260.8423947006625, 1274.3564499927663, 1283.6213317071486, 1297.4874924404808, 6045.939540604538, 6139.324674285825, 6154.815355539252, 6205.503559715212, 6237.812865614039, 6679.76620818269, 6680.498962577826, 6699.665016749143, 6705.0, 6712.496562757813, 5868.530517558585, 6007.219061521974, 6072.939270607326, 6118.265808103056, 6160.1375807387, 3446.965530344715, 3470.455647237006, 3473.2706131712116, 3496.9334353022573, 3509.12271932017, 6833.726650934006, 6877.58734475933, 6886.965565172242, 6977.860442791116, 6979.685914133876, 6854.224039264106, 6859.0, 6912.516123871382, 7003.789886303419, 7027.4378049756915, 6983.511154219156, 6991.755288564876, 7009.1589009319205, 7010.088688470568, 7022.859542809013, 6610.405063544112, 6645.468362530889, 6699.5310328276555, 6699.7990060296315, 6729.764458243938, 6655.866882662416, 6669.5664781790965, 6699.9665001674675, 6708.798736037927, 6735.797926062226, 6924.307569243036, 6967.965160174167, 7003.299670032956, 7014.7022800782015, 7033.859322813412, 5132.30713853625, 5135.897282054413, 5159.922601160911, 5168.508991645787, 5169.638125331191, 6382.744690212339, 6535.379138981789, 6597.50518711089, 6606.867862642816, 6637.303083176197, 6466.288708241996, 6493.610383377012, 6497.5126865484335, 6519.576227545194, 6537.8692426152165, 6410.326915673787, 6442.677866106582, 6475.190601174853, 6483.513736469878, 6532.150820393318, 6437.903431448438, 6465.321141280097, 6499.38255865692, 6541.182352205974, 6552.312007239362, 6484.221893372825, 6484.351564843478, 6561.80314590563, 6597.175353080865, 6598.142241508765, 6377.4579160771855, 6401.519886008475, 6420.486361091008, 6424.4986482366285, 6452.838679033061], "value": 5146.421457577212, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [955.2549011770822, 984.7587341101429, 1009.4498498318418, 1016.0601443664608, 1016.4714348538764, 19975.30086446973, 20518.38444846653, 20716.27493037744, 20723.378298651027, 23451.5309693806, 22601.321960341174, 22931.541369172606, 22976.310710678707, 22989.080436782508, 23013.539729205408, 1033.1373303291741, 1061.3101484035362, 1061.5647584490362, 1061.7027232374908, 1063.0220197418355, 1032.7211652853725, 1070.2026989892502, 1074.1782536359692, 1083.0847933496184, 1083.5990683447135, 1127.334872425273, 1128.90968722502, 1130.604288499023, 1130.864296284447, 1131.592626654408, 1122.4892673833426, 1125.6341688951084, 1128.6783266768932, 1128.7065363005636, 1130.028175768838, 832.2967092806568, 833.8624127019035, 834.7495751274594, 834.8205135895751, 835.1856939483954, 18880.905595471933, 18986.05069746507, 19022.714659279984, 20273.189072437086, 21118.260860869796, 22752.886235568883, 22932.19737309203, 23448.179313724107, 23565.0, 23740.762592374027, 17635.382761603283, 18006.729899051526, 18229.997350145735, 18493.167807448695, 18649.25402983879, 3921.6470517653547, 3943.2310699413624, 3954.8022598869943, 3955.9406608900604, 3958.2281455116263, 142320.01879934256, 143455.0, 143685.2815735925, 144980.0, 147824.0, 16693.165341732863, 16998.83001169997, 17604.647907041788, 17669.469915902544, 17687.73468397975, 32608.184795380304, 33856.32287354239, 33933.83033084868, 33959.0, 34122.0, 9246.214071803837, 9368.203702685349, 9373.531323433801, 9380.624775009059, 9392.0, 4790.257510085942, 4875.268709693503, 4876.292937524039, 4877.268409738496, 4880.072786170616, 5586.441355864381, 5723.971380143073, 5724.971375143181, 5730.312362516442, 5755.85610359736, 1067.3115840282974, 1090.7273181704575, 1106.4744246483017, 1106.6071544601712, 1107.778444311141, 707.5153519838824, 725.3508110241304, 731.3929438565978, 732.0739264829995, 747.9139898911695, 12668.556600518938, 12671.556495522613, 12720.236785792697, 13093.934530327288, 13211.895204626904, 646.5732616473199, 654.3423859021748, 662.2483481248818, 666.8299583606247, 670.4535803320279, 6377.3303803100935, 6379.266384365765, 6440.4847612190915, 6456.612603243821, 6486.4486518646445, 135356.0, 136297.3185134068, 136657.33986209694, 137822.0, 140214.0, 120285.0, 121858.0, 124940.0, 124974.0, 126045.36977315055, 99290.0, 99878.0, 101157.49421252847, 101252.49373753232, 101256.49371753242, 12054.0, 12068.818967715315, 12160.878391215974, 12262.26426414418, 12576.434060467484, 50049.49950500594, 51066.48933510618, 52208.47791522036, 52302.0, 54777.726111369186, 86709.56645216733, 87046.56476717576, 88291.55854220944, 88796.0, 94483.0, 18373.72439413383, 18437.87964384113, 18543.907280464053, 18708.158132884324, 18780.154893029572, 19675.508112297306, 20002.799972000095, 20045.79954200439, 21077.0, 21464.678029829876, 20829.479263018547, 21405.78594214038, 21750.564988700455, 21796.89101554482, 21817.56364872662, 21130.260440884496, 21264.043118060035, 21695.674564881854, 21745.0, 21826.56346873022, 20174.49563760859, 20227.59544809125, 20326.491837703583, 20560.58878822445, 20599.897000514902, 14549.563513094625, 14649.70700585961, 14839.851601483848, 14890.627734306729, 14930.477433289783, 15293.770593440884, 15566.9221653891, 15969.121698306704, 16275.755863661818, 16442.671146576762], "value": 10110.930884068504, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1432.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 105.0, 96.0, 109.0, 107.0, 105.0, 107.0, 96.0, 105.0, 107.0], "value": 103.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 112.0, 140.0, 170.0, 126.0, 134.0, 147.0, 113.0, 167.0, 112.0], "value": 135.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 164.0, 163.0, 163.0, 162.0, 167.0, 162.0, 161.0, 164.0, 165.0], "value": 163.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 82.0, 78.0, 171.0, 74.0, 74.0, 73.0, 73.0, 153.0, 77.0], "value": 92.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 123.0, 78.0, 78.0, 79.0, 131.0, 78.0, 78.0, 130.0], "value": 93.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 113.0, 114.0, 113.0, 114.0, 114.0, 114.0], "value": 113.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 155.0, 149.0, 150.0, 149.0, 150.0, 150.0, 151.0, 149.0, 149.0], "value": 150.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 93.0, 95.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0], "value": 94.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [44.0, 45.0, 44.0, 43.0, 43.0, 43.0, 44.0, 44.0, 43.0, 44.0], "value": 43.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 37.0, 37.0, 37.0, 37.0, 37.0, 37.0, 37.0, 37.0, 37.0], "value": 37.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 71.0, 73.0, 73.0, 74.0, 72.0, 73.0, 77.0, 73.0, 72.0], "value": 73.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 109.0, 114.0, 117.0, 117.0, 112.0, 107.0, 117.0, 110.0, 159.0], "value": 117.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 158.0, 158.0, 152.0, 153.0, 154.0, 160.0, 166.0, 153.0, 155.0], "value": 156.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 61.0, 59.0, 58.0, 59.0, 59.0, 58.0, 59.0, 60.0, 61.0], "value": 59.3, "unit": "score"}]}]} 05:58:57 INFO - Return code: 0 05:58:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:58:57 INFO - # TBPL SUCCESS # 05:58:57 INFO - Running post-action listener: _package_coverage_data 05:58:57 INFO - Running post-action listener: _resource_record_post_action 05:58:57 INFO - [mozharness: 2017-09-07 12:58:57.748387Z] Finished run-tests step (success) 05:58:57 INFO - Running post-run listener: _resource_record_post_run 05:58:57 INFO - Total resource usage - Wall time: 1184s; CPU: 13.0%; Read bytes: 442368; Write bytes: 397975552; Read time: 200; Write time: 239520 05:58:57 INFO - TinderboxPrint: CPU usage
13.0% 05:58:57 INFO - TinderboxPrint: I/O read bytes / time
442,368 / 200 05:58:57 INFO - TinderboxPrint: I/O write bytes / time
397,975,552 / 239,520 05:58:57 INFO - TinderboxPrint: CPU idle
8,207.2 (86.9%) 05:58:57 INFO - TinderboxPrint: CPU user
1,184.6 (12.5%) 05:58:57 INFO - TinderboxPrint: Swap in / out
0 / 0 05:58:57 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 117075968; Read time: 128; Write time: 96504 05:58:57 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 05:58:57 INFO - run-tests - Wall time: 1168s; CPU: 13.0%; Read bytes: 438272; Write bytes: 280489984; Read time: 72; Write time: 142988 05:58:58 INFO - Running post-run listener: _upload_blobber_files 05:58:58 INFO - Blob upload gear active. 05:58:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:58:58 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 05:58:58 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'] 05:58:58 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 05:58:58 INFO - (blobuploader) - INFO - Open directory for files ... 05:58:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:58:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:58:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:58:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:58:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:58:59 INFO - (blobuploader) - INFO - Done attempting. 05:58:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:58:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:58:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:59:00 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:59:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:59:00 INFO - (blobuploader) - INFO - Done attempting. 05:59:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:59:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:59:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:59:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:59:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:59:04 INFO - (blobuploader) - INFO - Done attempting. 05:59:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:59:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:59:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:59:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:59:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:59:05 INFO - (blobuploader) - INFO - Done attempting. 05:59:05 INFO - (blobuploader) - INFO - Iteration through files over. 05:59:05 INFO - Return code: 0 05:59:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:59:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:59:05 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a136f46b514cc4aea4a3dde5278e2bed4cfd6c20529421a43b4cc085d0df6824e535dcf771294d3125b5d7ff198638eea2479bb17b1f85e9c8a1c46fcd2345fd", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/56c51d8295190417ee601b0c57e319466e178723bc85135bed22ef3e0d63872c9465bba67763c0cb8f36d70e86bd03febc1ee7ca54273afd53adcd8145fc325d", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e87d60a59dc840926c154ba87f1b3377191bf5ec171e651f8aa0f48beb4f0e58db362c2b9a703956008d1fecfca9c50ccdc934e1d413e0b30ce2f96067d88e73", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/28e3b01128e15d425d28e6f7c6687e751bfd2d2d4905e2985cea024f96052bcb4589e945013bb279d7dfe97e8497a61b35291e465ce4e06cedecc7bcee6c943f"} 05:59:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:59:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:59:05 INFO - Contents: 05:59:05 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a136f46b514cc4aea4a3dde5278e2bed4cfd6c20529421a43b4cc085d0df6824e535dcf771294d3125b5d7ff198638eea2479bb17b1f85e9c8a1c46fcd2345fd", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/56c51d8295190417ee601b0c57e319466e178723bc85135bed22ef3e0d63872c9465bba67763c0cb8f36d70e86bd03febc1ee7ca54273afd53adcd8145fc325d", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e87d60a59dc840926c154ba87f1b3377191bf5ec171e651f8aa0f48beb4f0e58db362c2b9a703956008d1fecfca9c50ccdc934e1d413e0b30ce2f96067d88e73", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/28e3b01128e15d425d28e6f7c6687e751bfd2d2d4905e2985cea024f96052bcb4589e945013bb279d7dfe97e8497a61b35291e465ce4e06cedecc7bcee6c943f"} 05:59:05 INFO - Running post-run listener: copy_logs_to_upload_dir 05:59:05 INFO - Copying logs to upload dir... 05:59:05 INFO - mkdir: /builds/slave/test/build/upload/logs 05:59:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.479374 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2017-09-07 05:59:05.321447) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-07 05:59:05.326941) ========= 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=483e410453545d07cca6935c000001ab-1504787899.862163-2100156443 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a136f46b514cc4aea4a3dde5278e2bed4cfd6c20529421a43b4cc085d0df6824e535dcf771294d3125b5d7ff198638eea2479bb17b1f85e9c8a1c46fcd2345fd", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/56c51d8295190417ee601b0c57e319466e178723bc85135bed22ef3e0d63872c9465bba67763c0cb8f36d70e86bd03febc1ee7ca54273afd53adcd8145fc325d", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e87d60a59dc840926c154ba87f1b3377191bf5ec171e651f8aa0f48beb4f0e58db362c2b9a703956008d1fecfca9c50ccdc934e1d413e0b30ce2f96067d88e73", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/28e3b01128e15d425d28e6f7c6687e751bfd2d2d4905e2985cea024f96052bcb4589e945013bb279d7dfe97e8497a61b35291e465ce4e06cedecc7bcee6c943f"} build_url:https://queue.taskcluster.net/v1/task/THhrxJvGRaSBpbmI92T5WQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011065 build_url: 'https://queue.taskcluster.net/v1/task/THhrxJvGRaSBpbmI92T5WQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a136f46b514cc4aea4a3dde5278e2bed4cfd6c20529421a43b4cc085d0df6824e535dcf771294d3125b5d7ff198638eea2479bb17b1f85e9c8a1c46fcd2345fd", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/56c51d8295190417ee601b0c57e319466e178723bc85135bed22ef3e0d63872c9465bba67763c0cb8f36d70e86bd03febc1ee7ca54273afd53adcd8145fc325d", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e87d60a59dc840926c154ba87f1b3377191bf5ec171e651f8aa0f48beb4f0e58db362c2b9a703956008d1fecfca9c50ccdc934e1d413e0b30ce2f96067d88e73", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/28e3b01128e15d425d28e6f7c6687e751bfd2d2d4905e2985cea024f96052bcb4589e945013bb279d7dfe97e8497a61b35291e465ce4e06cedecc7bcee6c943f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-07 05:59:05.357012) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 05:59:05.357543) ========= 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=483e410453545d07cca6935c000001ab-1504787899.862163-2100156443 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004452 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 05:59:05.438928) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-07 05:59:05.439329) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-07 05:59:05.439622) ========= ========= Total master_lag: 0.21 =========