builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-014 starttime: 1504392920.67 results: success (0) revision: 39e9a6b187a3f71f46d02af000ff8203abe4fe71 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-02 15:55:20.672032) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-02 15:55:20.672530) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-02 15:55:20.672824) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-02 15:55:20.690991) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-02 15:55:20.691383) ========= 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=31acecf42b6a79ec49471d4a000001bb-1504392919.881673-574566209 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-02 15:55:20-- 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% 46.4M=0s 2017-09-02 15:55:20 (46.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.116403 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-02 15:55:20.824919) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-02 15:55:20.825245) ========= 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=31acecf42b6a79ec49471d4a000001bb-1504392919.881673-574566209 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018934 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-02 15:55:20.874899) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-02 15:55:20.875238) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 39e9a6b187a3f71f46d02af000ff8203abe4fe71 --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 39e9a6b187a3f71f46d02af000ff8203abe4fe71 --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=31acecf42b6a79ec49471d4a000001bb-1504392919.881673-574566209 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-02 15:55:20,924 truncating revision to first 12 chars 2017-09-02 15:55:20,924 Setting DEBUG logging. 2017-09-02 15:55:20,924 attempt 1/10 2017-09-02 15:55:20,925 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/39e9a6b187a3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-02 15:55:21,383 unpacking tar archive at: mozilla-central-39e9a6b187a3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.751155 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-02 15:55:21.644951) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-02 15:55:21.645578) ========= script_repo_revision: 39e9a6b187a3f71f46d02af000ff8203abe4fe71 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-02 15:55:21.646260) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-02 15:55:21.646725) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-02 15:55:21.662140) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-09-02 15:55:21.662681) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=31acecf42b6a79ec49471d4a000001bb-1504392919.881673-574566209 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:55:21 INFO - MultiFileLogger online at 20170902 15:55:21 in /builds/slave/test 15:55:21 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 15:55:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:55:21 INFO - {'append_to_log': False, 15:55:21 INFO - 'base_work_dir': '/builds/slave/test', 15:55:21 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 15:55:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:55:21 INFO - 'branch': 'Firefox-Non-PGO', 15:55:21 INFO - 'buildbot_json_path': 'buildprops.json', 15:55:21 INFO - 'code_coverage': False, 15:55:21 INFO - 'config_files': ('talos/linux_config.py',), 15:55:21 INFO - 'default_actions': ('clobber', 15:55:21 INFO - 'read-buildbot-config', 15:55:21 INFO - 'download-and-extract', 15:55:21 INFO - 'populate-webroot', 15:55:21 INFO - 'create-virtualenv', 15:55:21 INFO - 'install', 15:55:21 INFO - 'setup-mitmproxy', 15:55:21 INFO - 'run-tests'), 15:55:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:55:21 INFO - 'disable_ccov_upload': False, 15:55:21 INFO - 'disable_stylo': False, 15:55:21 INFO - 'download_minidump_stackwalk': True, 15:55:21 INFO - 'download_symbols': 'ondemand', 15:55:21 INFO - 'enable_stylo': False, 15:55:21 INFO - 'enable_webrender': False, 15:55:21 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 15:55:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:55:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:55:21 INFO - 'gecko_profile': False, 15:55:21 INFO - 'gecko_profile_interval': 0, 15:55:21 INFO - 'installer_path': 'installer.exe', 15:55:21 INFO - 'log_level': 'info', 15:55:21 INFO - 'log_name': 'talos', 15:55:21 INFO - 'log_to_console': True, 15:55:21 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:55:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:55:21 INFO - 'opt_config_files': (), 15:55:21 INFO - 'pip_index': False, 15:55:21 INFO - 'suite': 'dromaeojs-e10s', 15:55:21 INFO - 'system_bits': '32', 15:55:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:55:21 INFO - 'title': 'talos-linux64-ix-014', 15:55:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:55:21 INFO - 'use_talos_json': True, 15:55:21 INFO - 'verify': 'False', 15:55:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:55:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:55:21 INFO - 'work_dir': 'build'} 15:55:21 INFO - [mozharness: 2017-09-02 22:55:21.853580Z] Running clobber step. 15:55:21 INFO - Running pre-action listener: _resource_record_pre_action 15:55:21 INFO - Running main action method: clobber 15:55:21 INFO - rmtree: /builds/slave/test/build 15:55:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:55:22 INFO - Running post-action listener: _resource_record_post_action 15:55:22 INFO - [mozharness: 2017-09-02 22:55:22.990860Z] Finished clobber step (success) 15:55:22 INFO - [mozharness: 2017-09-02 22:55:22.990958Z] Running read-buildbot-config step. 15:55:22 INFO - Running pre-action listener: _resource_record_pre_action 15:55:22 INFO - Running main action method: read_buildbot_config 15:55:22 INFO - Using buildbot properties: 15:55:22 INFO - { 15:55:22 INFO - "project": "", 15:55:22 INFO - "product": "firefox", 15:55:22 INFO - "who": "archaeopteryx@coole-files.de", 15:55:22 INFO - "installer_path": "public/build/target.tar.bz2", 15:55:22 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 15:55:22 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 15:55:22 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 15:55:22 INFO - "stage_platform": "linux64", 15:55:22 INFO - "basedir": "/builds/slave/test", 15:55:22 INFO - "buildnumber": 1112, 15:55:22 INFO - "platform": "ubuntu64_hw", 15:55:22 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:55:22 INFO - "slavebuilddir": "test", 15:55:22 INFO - "taskId": "aUDbaWknRnG87sgmwk0YfA", 15:55:22 INFO - "branch": "mozilla-central", 15:55:22 INFO - "script_repo_revision": "production", 15:55:22 INFO - "revision": "39e9a6b187a3f71f46d02af000ff8203abe4fe71", 15:55:22 INFO - "slavename": "talos-linux64-ix-014", 15:55:22 INFO - "repo_path": "mozilla-central" 15:55:22 INFO - } 15:55:22 INFO - Finding installer, test and symbols from parent task. 15:55:22 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aUDbaWknRnG87sgmwk0YfA'}, attempt #1 15:55:23 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aUDbaWknRnG87sgmwk0YfA'}, attempt #1 15:55:23 INFO - Task dependencies: EForbR1USZeEN3w5edfxHw 15:55:23 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EForbR1USZeEN3w5edfxHw'}, attempt #1 15:55:24 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/EForbR1USZeEN3w5edfxHw/artifacts/public/build/target.tar.bz2 15:55:24 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/EForbR1USZeEN3w5edfxHw/artifacts/public/build/target.test_packages.json 15:55:24 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/EForbR1USZeEN3w5edfxHw/artifacts/public/build/target.crashreporter-symbols.zip 15:55:24 INFO - Running post-action listener: _resource_record_post_action 15:55:24 INFO - [mozharness: 2017-09-02 22:55:24.361060Z] Finished read-buildbot-config step (success) 15:55:24 INFO - [mozharness: 2017-09-02 22:55:24.361277Z] Running download-and-extract step. 15:55:24 INFO - Running pre-action listener: _resource_record_pre_action 15:55:24 INFO - Running main action method: download_and_extract 15:55:24 INFO - mkdir: /builds/slave/test/build/tests 15:55:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:55:24 INFO - trying https://queue.taskcluster.net/v1/task/EForbR1USZeEN3w5edfxHw/artifacts/public/build/target.test_packages.json 15:55:24 INFO - Downloading https://queue.taskcluster.net/v1/task/EForbR1USZeEN3w5edfxHw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 15:55:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EForbR1USZeEN3w5edfxHw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 15:55:24 INFO - Downloaded 989 bytes. 15:55:24 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 15:55:24 INFO - Using the following test package requirements: 15:55:24 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 15:55:24 INFO - u'common': [u'target.common.tests.zip'], 15:55:24 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 15:55:24 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 15:55:24 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 15:55:24 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 15:55:24 INFO - u'mozbase': [u'target.common.tests.zip'], 15:55:24 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 15:55:24 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 15:55:24 INFO - u'web-platform': [u'target.common.tests.zip', 15:55:24 INFO - u'target.web-platform.tests.tar.gz'], 15:55:24 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 15:55:24 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 15:55:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EForbR1USZeEN3w5edfxHw/artifacts/public/build/target.common.tests.zip 15:55:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EForbR1USZeEN3w5edfxHw/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:55:24 INFO - Fetch https://queue.taskcluster.net/v1/task/EForbR1USZeEN3w5edfxHw/artifacts/public/build/target.common.tests.zip into memory 15:55:25 INFO - Content-Length response header: 55022272 15:55:25 INFO - Bytes received: 55022272 15:55:36 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 15:55:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EForbR1USZeEN3w5edfxHw/artifacts/public/build/target.common.tests.zip 15:55:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EForbR1USZeEN3w5edfxHw/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:55:36 INFO - Fetch https://queue.taskcluster.net/v1/task/EForbR1USZeEN3w5edfxHw/artifacts/public/build/target.common.tests.zip into memory 15:55:37 INFO - Content-Length response header: 55022272 15:55:37 INFO - Bytes received: 55022272 15:55:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EForbR1USZeEN3w5edfxHw/artifacts/public/build/target.talos.tests.zip 15:55:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EForbR1USZeEN3w5edfxHw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 15:55:49 INFO - Fetch https://queue.taskcluster.net/v1/task/EForbR1USZeEN3w5edfxHw/artifacts/public/build/target.talos.tests.zip into memory 15:55:50 INFO - Content-Length response header: 14496650 15:55:50 INFO - Bytes received: 14496650 15:55:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:55:50 INFO - trying https://queue.taskcluster.net/v1/task/EForbR1USZeEN3w5edfxHw/artifacts/public/build/target.tar.bz2 15:55:50 INFO - Downloading https://queue.taskcluster.net/v1/task/EForbR1USZeEN3w5edfxHw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 15:55:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EForbR1USZeEN3w5edfxHw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 15:55:51 INFO - Downloaded 62762602 bytes. 15:55:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EForbR1USZeEN3w5edfxHw/artifacts/public/build/target.tar.bz2 15:55:51 INFO - mkdir: /builds/slave/test/properties 15:55:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:55:51 INFO - Writing to file /builds/slave/test/properties/build_url 15:55:51 INFO - Contents: 15:55:51 INFO - build_url:https://queue.taskcluster.net/v1/task/EForbR1USZeEN3w5edfxHw/artifacts/public/build/target.tar.bz2 15:55:51 INFO - Running post-action listener: _resource_record_post_action 15:55:51 INFO - Running post-action listener: find_tests_for_verification 15:55:51 INFO - Running post-action listener: set_extra_try_arguments 15:55:51 INFO - [mozharness: 2017-09-02 22:55:51.930059Z] Finished download-and-extract step (success) 15:55:51 INFO - [mozharness: 2017-09-02 22:55:51.930156Z] Running populate-webroot step. 15:55:51 INFO - Running pre-action listener: _resource_record_pre_action 15:55:51 INFO - Running main action method: populate_webroot 15:55:51 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:55:51 INFO - 'chromez-stylo-e10s': {'talos_options': ['--enable-stylo'], 15:55:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:55:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:55:51 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--enable-stylo'], 15:55:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:55:51 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:55:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:55:51 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 15:55:51 INFO - 'talos_options': ['--enable-stylo'], 15:55:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:55:51 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:55:51 INFO - 'tests': ['damp', 'tps']}, 15:55:51 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 15:55:51 INFO - 'talos_options': ['--enable-stylo'], 15:55:51 INFO - 'tests': ['damp', 'tps']}, 15:55:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:55:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 15:55:51 INFO - 'g4-stylo-e10s': {'talos_options': ['--enable-stylo'], 15:55:51 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 15:55:51 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 15:55:51 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 15:55:51 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 15:55:51 INFO - 'talos_options': ['--enable-stylo'], 15:55:51 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 15:55:51 INFO - 'other-e10s': {'tests': ['a11yr', 15:55:51 INFO - 'ts_paint', 15:55:51 INFO - 'tpaint', 15:55:51 INFO - 'sessionrestore', 15:55:51 INFO - 'sessionrestore_many_windows', 15:55:51 INFO - 'sessionrestore_no_auto_restore', 15:55:51 INFO - 'tabpaint']}, 15:55:51 INFO - 'other-stylo-e10s': {'talos_options': ['--enable-stylo'], 15:55:51 INFO - 'tests': ['a11yr', 15:55:51 INFO - 'ts_paint', 15:55:51 INFO - 'tpaint', 15:55:51 INFO - 'sessionrestore', 15:55:51 INFO - 'sessionrestore_many_windows', 15:55:51 INFO - 'sessionrestore_no_auto_restore', 15:55:51 INFO - 'tabpaint']}, 15:55:51 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 15:55:51 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 15:55:51 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--enable-stylo'], 15:55:51 INFO - 'tests': ['bloom_basic_singleton']}, 15:55:51 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--enable-stylo'], 15:55:51 INFO - 'tests': ['bloom_basic']}, 15:55:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:55:51 INFO - 'tsvgr_opacity', 15:55:51 INFO - 'tart', 15:55:51 INFO - 'tscrollx', 15:55:51 INFO - 'tsvg_static']}, 15:55:51 INFO - 'svgr-stylo-e10s': {'talos_options': ['--enable-stylo'], 15:55:51 INFO - 'tests': ['tsvgx', 15:55:51 INFO - 'tsvgr_opacity', 15:55:51 INFO - 'tart', 15:55:51 INFO - 'tscrollx', 15:55:51 INFO - 'tsvg_static']}, 15:55:51 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:55:51 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 15:55:51 INFO - 'talos_options': ['--enable-stylo'], 15:55:51 INFO - 'tests': ['tp5o']}, 15:55:51 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:55:51 INFO - 'talos_options': ['--mitmproxy', 15:55:51 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:55:51 INFO - '--firstNonBlankPaint'], 15:55:51 INFO - 'tests': ['tp6_google', 15:55:51 INFO - 'tp6_youtube', 15:55:51 INFO - 'tp6_amazon', 15:55:51 INFO - 'tp6_facebook']}, 15:55:51 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:55:51 INFO - 'talos_options': ['--enable-stylo', 15:55:51 INFO - '--mitmproxy', 15:55:51 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:55:51 INFO - '--firstNonBlankPaint'], 15:55:51 INFO - 'tests': ['tp6_google', 15:55:51 INFO - 'tp6_youtube', 15:55:51 INFO - 'tp6_amazon', 15:55:51 INFO - 'tp6_facebook']}, 15:55:51 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:55:51 INFO - 'talos_options': ['--enable-stylo', 15:55:51 INFO - '--stylo-threads=1', 15:55:51 INFO - '--mitmproxy', 15:55:51 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:55:51 INFO - '--firstNonBlankPaint'], 15:55:51 INFO - 'tests': ['tp6_google', 15:55:51 INFO - 'tp6_youtube', 15:55:51 INFO - 'tp6_amazon', 15:55:51 INFO - 'tp6_facebook']}, 15:55:51 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:55:51 INFO - 'talos_options': ['--xperf_path', 15:55:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:55:51 INFO - 'tests': ['tp5n']}, 15:55:51 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 15:55:51 INFO - 'talos_options': ['--enable-stylo', 15:55:51 INFO - '--xperf_path', 15:55:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:55:51 INFO - 'tests': ['tp5n']}}} 15:55:51 INFO - Running post-action listener: _resource_record_post_action 15:55:51 INFO - [mozharness: 2017-09-02 22:55:51.944465Z] Finished populate-webroot step (success) 15:55:51 INFO - [mozharness: 2017-09-02 22:55:51.944554Z] Running create-virtualenv step. 15:55:51 INFO - Running pre-action listener: _resource_record_pre_action 15:55:51 INFO - Running main action method: create_virtualenv 15:55:51 INFO - Creating virtualenv /builds/slave/test/build/venv 15:55:51 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:55:51 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 15:55:51 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 15:55:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:55:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:55:52 INFO - Installing distribute.............................................................................................................................................................................................done. 15:55:52 INFO - Installing pip...............done. 15:55:52 INFO - Return code: 0 15:55:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:55:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:55:52 INFO - Reading from file tmpfile_stdout 15:55:52 INFO - Output received: 15:55:52 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 15:55:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:55:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:55:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:55:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:55:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:55:52 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 0xdb21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x111ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1122090>, '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 0x1122d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x111cf90>, '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': '31acecf42b6a79ec49471d4a000001bb-1504392919.881673-574566209', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:55:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:55:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:55:52 INFO - Using env: {'DISPLAY': ':0', 15:55:52 INFO - 'HOME': '/home/cltbld', 15:55:52 INFO - 'LANG': 'en_US.UTF-8', 15:55:52 INFO - 'LANGUAGE': 'en_US:en', 15:55:52 INFO - 'LOGNAME': 'cltbld', 15:55:52 INFO - 'MAIL': '/var/mail/cltbld', 15:55:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:55:52 INFO - 'MOZ_NO_REMOTE': '1', 15:55:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:55:52 INFO - 'NO_EM_RESTART': '1', 15:55:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:55:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:55:52 INFO - 'PWD': '/builds/slave/test', 15:55:52 INFO - 'SHELL': '/bin/bash', 15:55:52 INFO - 'SHLVL': '1', 15:55:52 INFO - 'TERM': 'linux', 15:55:52 INFO - 'TMOUT': '86400', 15:55:52 INFO - 'USER': 'cltbld', 15:55:52 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1504392919.881673-574566209', 15:55:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:55:52 INFO - '_': '/tools/buildbot/bin/python'} 15:55:54 INFO - Ignoring indexes: http://pypi.python.org/simple/ 15:55:54 INFO - Downloading/unpacking pip>=1.5 15:55:54 INFO - Running setup.py egg_info for package pip 15:55:54 INFO - warning: no files found matching 'pip/cacert.pem' 15:55:54 INFO - warning: no files found matching '*.html' under directory 'docs' 15:55:54 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:55:54 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:55:54 INFO - Installing collected packages: pip 15:55:54 INFO - Found existing installation: pip 1.1 15:55:54 INFO - Uninstalling pip: 15:55:54 INFO - Successfully uninstalled pip 15:55:54 INFO - Running setup.py install for pip 15:55:54 INFO - warning: no files found matching 'pip/cacert.pem' 15:55:54 INFO - warning: no files found matching '*.html' under directory 'docs' 15:55:54 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:55:54 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:55:54 INFO - Installing pip script to /builds/slave/test/build/venv/bin 15:55:54 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 15:55:54 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 15:55:54 INFO - Successfully installed pip 15:55:54 INFO - Cleaning up... 15:55:54 INFO - Return code: 0 15:55:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:55:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:55:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:55:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:55:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:55:54 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 0xdb21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x111ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1122090>, '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 0x1122d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x111cf90>, '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': '31acecf42b6a79ec49471d4a000001bb-1504392919.881673-574566209', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:55:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:55:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:55:54 INFO - Using env: {'DISPLAY': ':0', 15:55:54 INFO - 'HOME': '/home/cltbld', 15:55:54 INFO - 'LANG': 'en_US.UTF-8', 15:55:54 INFO - 'LANGUAGE': 'en_US:en', 15:55:54 INFO - 'LOGNAME': 'cltbld', 15:55:54 INFO - 'MAIL': '/var/mail/cltbld', 15:55:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:55:54 INFO - 'MOZ_NO_REMOTE': '1', 15:55:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:55:54 INFO - 'NO_EM_RESTART': '1', 15:55:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:55:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:55:54 INFO - 'PWD': '/builds/slave/test', 15:55:54 INFO - 'SHELL': '/bin/bash', 15:55:54 INFO - 'SHLVL': '1', 15:55:54 INFO - 'TERM': 'linux', 15:55:54 INFO - 'TMOUT': '86400', 15:55:54 INFO - 'USER': 'cltbld', 15:55:54 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1504392919.881673-574566209', 15:55:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:55:54 INFO - '_': '/tools/buildbot/bin/python'} 15:55:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:55:54 INFO - Downloading/unpacking psutil>=3.1.1 15:55:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:55:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:55:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:55:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:55:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:55:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:55:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:55:55 INFO - Installing collected packages: psutil 15:55:55 INFO - Running setup.py install for psutil 15:55:55 INFO - building 'psutil._psutil_linux' extension 15:55:55 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:55:55 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:55:55 INFO - building 'psutil._psutil_posix' extension 15:55:55 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 15:55:55 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:55:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:55:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:55:55 INFO - Successfully installed psutil 15:55:55 INFO - Cleaning up... 15:55:56 INFO - Return code: 0 15:55:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:55: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')]} 15:55:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:55: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')]} 15:55:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:55: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdb21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x111ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1122090>, '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 0x1122d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x111cf90>, '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': '31acecf42b6a79ec49471d4a000001bb-1504392919.881673-574566209', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:55: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:55: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 mozsystemmonitor==0.3 15:55:56 INFO - Using env: {'DISPLAY': ':0', 15:55:56 INFO - 'HOME': '/home/cltbld', 15:55:56 INFO - 'LANG': 'en_US.UTF-8', 15:55:56 INFO - 'LANGUAGE': 'en_US:en', 15:55:56 INFO - 'LOGNAME': 'cltbld', 15:55:56 INFO - 'MAIL': '/var/mail/cltbld', 15:55:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:55:56 INFO - 'MOZ_NO_REMOTE': '1', 15:55:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:55:56 INFO - 'NO_EM_RESTART': '1', 15:55:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:55:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:55:56 INFO - 'PWD': '/builds/slave/test', 15:55:56 INFO - 'SHELL': '/bin/bash', 15:55:56 INFO - 'SHLVL': '1', 15:55:56 INFO - 'TERM': 'linux', 15:55:56 INFO - 'TMOUT': '86400', 15:55:56 INFO - 'USER': 'cltbld', 15:55:56 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1504392919.881673-574566209', 15:55:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:55:56 INFO - '_': '/tools/buildbot/bin/python'} 15:55:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:55:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:55: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 15:55: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 15:55: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 15:55: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 15:55:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:55:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:55:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:55:57 INFO - Installing collected packages: mozsystemmonitor 15:55:57 INFO - Running setup.py install for mozsystemmonitor 15:55:57 INFO - Successfully installed mozsystemmonitor 15:55:57 INFO - Cleaning up... 15:55:57 INFO - Return code: 0 15:55:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:55:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:55:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:55:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:55:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:55:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xdb21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x111ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1122090>, '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 0x1122d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x111cf90>, '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': '31acecf42b6a79ec49471d4a000001bb-1504392919.881673-574566209', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:55:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:55:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:55:57 INFO - Using env: {'DISPLAY': ':0', 15:55:57 INFO - 'HOME': '/home/cltbld', 15:55:57 INFO - 'LANG': 'en_US.UTF-8', 15:55:57 INFO - 'LANGUAGE': 'en_US:en', 15:55:57 INFO - 'LOGNAME': 'cltbld', 15:55:57 INFO - 'MAIL': '/var/mail/cltbld', 15:55:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:55:57 INFO - 'MOZ_NO_REMOTE': '1', 15:55:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:55:57 INFO - 'NO_EM_RESTART': '1', 15:55:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:55:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:55:57 INFO - 'PWD': '/builds/slave/test', 15:55:57 INFO - 'SHELL': '/bin/bash', 15:55:57 INFO - 'SHLVL': '1', 15:55:57 INFO - 'TERM': 'linux', 15:55:57 INFO - 'TMOUT': '86400', 15:55:57 INFO - 'USER': 'cltbld', 15:55:57 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1504392919.881673-574566209', 15:55:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:55:57 INFO - '_': '/tools/buildbot/bin/python'} 15:55:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:55:57 INFO - Downloading/unpacking jsonschema==2.5.1 15:55:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:55:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:55:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:55:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:55:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:55:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:55:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:55:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:55:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:55:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:55:58 INFO - Downloading functools32-3.2.3-2.tar.gz 15:55:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:55:58 INFO - warning: no files found matching '*.txt' 15:55:58 INFO - no previously-included directories found matching 'build' 15:55:58 INFO - no previously-included directories found matching 'dist' 15:55:59 INFO - no previously-included directories found matching '.git*' 15:55:59 INFO - Installing collected packages: jsonschema, functools32 15:55:59 INFO - Running setup.py install for functools32 15:55:59 INFO - warning: no files found matching '*.txt' 15:55:59 INFO - no previously-included directories found matching 'build' 15:55:59 INFO - no previously-included directories found matching 'dist' 15:55:59 INFO - no previously-included directories found matching '.git*' 15:55:59 INFO - Successfully installed jsonschema functools32 15:55:59 INFO - Cleaning up... 15:55:59 INFO - Return code: 0 15:55:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:55:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:55:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:55:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:55:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:55:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xdb21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x111ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1122090>, '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 0x1122d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x111cf90>, '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': '31acecf42b6a79ec49471d4a000001bb-1504392919.881673-574566209', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:55:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:55:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:55:59 INFO - Using env: {'DISPLAY': ':0', 15:55:59 INFO - 'HOME': '/home/cltbld', 15:55:59 INFO - 'LANG': 'en_US.UTF-8', 15:55:59 INFO - 'LANGUAGE': 'en_US:en', 15:55:59 INFO - 'LOGNAME': 'cltbld', 15:55:59 INFO - 'MAIL': '/var/mail/cltbld', 15:55:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:55:59 INFO - 'MOZ_NO_REMOTE': '1', 15:55:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:55:59 INFO - 'NO_EM_RESTART': '1', 15:55:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:55:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:55:59 INFO - 'PWD': '/builds/slave/test', 15:55:59 INFO - 'SHELL': '/bin/bash', 15:55:59 INFO - 'SHLVL': '1', 15:55:59 INFO - 'TERM': 'linux', 15:55:59 INFO - 'TMOUT': '86400', 15:55:59 INFO - 'USER': 'cltbld', 15:55:59 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1504392919.881673-574566209', 15:55:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:55:59 INFO - '_': '/tools/buildbot/bin/python'} 15:55:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:55:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:55:59 INFO - Cleaning up... 15:55:59 INFO - Return code: 0 15:55:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:55:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:55:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:55:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:55:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:55:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xdb21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x111ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1122090>, '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 0x1122d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x111cf90>, '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': '31acecf42b6a79ec49471d4a000001bb-1504392919.881673-574566209', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:55:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:55:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:55:59 INFO - Using env: {'DISPLAY': ':0', 15:55:59 INFO - 'HOME': '/home/cltbld', 15:55:59 INFO - 'LANG': 'en_US.UTF-8', 15:55:59 INFO - 'LANGUAGE': 'en_US:en', 15:55:59 INFO - 'LOGNAME': 'cltbld', 15:55:59 INFO - 'MAIL': '/var/mail/cltbld', 15:55:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:55:59 INFO - 'MOZ_NO_REMOTE': '1', 15:55:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:55:59 INFO - 'NO_EM_RESTART': '1', 15:55:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:55:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:55:59 INFO - 'PWD': '/builds/slave/test', 15:55:59 INFO - 'SHELL': '/bin/bash', 15:55:59 INFO - 'SHLVL': '1', 15:55:59 INFO - 'TERM': 'linux', 15:55:59 INFO - 'TMOUT': '86400', 15:55:59 INFO - 'USER': 'cltbld', 15:55:59 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1504392919.881673-574566209', 15:55:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:55:59 INFO - '_': '/tools/buildbot/bin/python'} 15:55:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:55:59 INFO - Downloading/unpacking blobuploader==1.2.4 15:55:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:55:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:55:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:55:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:56:00 INFO - Downloading blobuploader-1.2.4.tar.gz 15:56:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:56:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:56:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:56:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:56:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:56:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:56:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:56:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:56: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 15:56: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 15:56: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 15:56: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 15:56:01 INFO - Downloading docopt-0.6.1.tar.gz 15:56:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:56:01 INFO - Installing collected packages: blobuploader, requests, docopt 15:56:01 INFO - Running setup.py install for blobuploader 15:56:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:56:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:56:01 INFO - Running setup.py install for requests 15:56:01 INFO - Running setup.py install for docopt 15:56:01 INFO - Successfully installed blobuploader requests docopt 15:56:01 INFO - Cleaning up... 15:56:01 INFO - Return code: 0 15:56:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:56: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')]} 15:56:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:56: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')]} 15:56:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:56:01 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 0xdb21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x111ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1122090>, '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 0x1122d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x111cf90>, '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': '31acecf42b6a79ec49471d4a000001bb-1504392919.881673-574566209', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:56:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:56:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:56:01 INFO - Using env: {'DISPLAY': ':0', 15:56:01 INFO - 'HOME': '/home/cltbld', 15:56:01 INFO - 'LANG': 'en_US.UTF-8', 15:56:01 INFO - 'LANGUAGE': 'en_US:en', 15:56:01 INFO - 'LOGNAME': 'cltbld', 15:56:01 INFO - 'MAIL': '/var/mail/cltbld', 15:56:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:56:01 INFO - 'MOZ_NO_REMOTE': '1', 15:56:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:56:01 INFO - 'NO_EM_RESTART': '1', 15:56:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:56:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:56:01 INFO - 'PWD': '/builds/slave/test', 15:56:01 INFO - 'SHELL': '/bin/bash', 15:56:01 INFO - 'SHLVL': '1', 15:56:01 INFO - 'TERM': 'linux', 15:56:01 INFO - 'TMOUT': '86400', 15:56:01 INFO - 'USER': 'cltbld', 15:56:01 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1504392919.881673-574566209', 15:56:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:56:01 INFO - '_': '/tools/buildbot/bin/python'} 15:56:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:56:02 INFO - Running setup.py (path:/tmp/pip-ScQp_R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:56:02 INFO - Running setup.py (path:/tmp/pip-fhjkEH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:56:02 INFO - Running setup.py (path:/tmp/pip-47Gfiz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:56:02 INFO - Running setup.py (path:/tmp/pip-OjML_D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:56:02 INFO - Running setup.py (path:/tmp/pip-qUmOD5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:56:02 INFO - Running setup.py (path:/tmp/pip-45jNwY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:56:02 INFO - Running setup.py (path:/tmp/pip-x7T5z4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:56:02 INFO - Running setup.py (path:/tmp/pip-0JO2gm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:56:02 INFO - Running setup.py (path:/tmp/pip-m1LXIq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:56:02 INFO - Running setup.py (path:/tmp/pip-26xhY8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:56:02 INFO - Running setup.py (path:/tmp/pip-S_FHK2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:56:02 INFO - Running setup.py (path:/tmp/pip-MQd_iM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:56:02 INFO - Running setup.py (path:/tmp/pip-LRznaC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:56:03 INFO - Running setup.py (path:/tmp/pip-9Bb6h4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:56:03 INFO - Running setup.py (path:/tmp/pip-IhKE4t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:56:03 INFO - Running setup.py (path:/tmp/pip-XAHu9K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:56:03 INFO - Running setup.py (path:/tmp/pip-hDnxOs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:56:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:56:03 INFO - Running setup.py install for manifestparser 15:56:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:56:03 INFO - Running setup.py install for mozcrash 15:56:03 INFO - Running setup.py install for mozdebug 15:56:03 INFO - Running setup.py install for mozdevice 15:56:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:56:03 INFO - Running setup.py install for mozfile 15:56:03 INFO - Running setup.py install for mozhttpd 15:56:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:56:03 INFO - Running setup.py install for mozinfo 15:56:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:56:04 INFO - Running setup.py install for mozInstall 15:56:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:56:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:56:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:56:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:56:04 INFO - Running setup.py install for mozleak 15:56:04 INFO - Running setup.py install for mozlog 15:56:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:56:04 INFO - Running setup.py install for moznetwork 15:56:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:56:04 INFO - Running setup.py install for mozprocess 15:56:04 INFO - Running setup.py install for mozprofile 15:56:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:56:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:56:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:56:04 INFO - Running setup.py install for mozrunner 15:56:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:56:04 INFO - Running setup.py install for mozscreenshot 15:56:04 INFO - Running setup.py install for moztest 15:56:04 INFO - Running setup.py install for mozversion 15:56:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:56:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:56:05 INFO - Cleaning up... 15:56:05 INFO - Return code: 0 15:56:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:56:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:56:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:56:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:56:05 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 0xdb21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x111ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1122090>, '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 0x1122d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x111cf90>, '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': '31acecf42b6a79ec49471d4a000001bb-1504392919.881673-574566209', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:56:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:56:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:56:05 INFO - Using env: {'DISPLAY': ':0', 15:56:05 INFO - 'HOME': '/home/cltbld', 15:56:05 INFO - 'LANG': 'en_US.UTF-8', 15:56:05 INFO - 'LANGUAGE': 'en_US:en', 15:56:05 INFO - 'LOGNAME': 'cltbld', 15:56:05 INFO - 'MAIL': '/var/mail/cltbld', 15:56:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:56:05 INFO - 'MOZ_NO_REMOTE': '1', 15:56:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:56:05 INFO - 'NO_EM_RESTART': '1', 15:56:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:56:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:56:05 INFO - 'PWD': '/builds/slave/test', 15:56:05 INFO - 'SHELL': '/bin/bash', 15:56:05 INFO - 'SHLVL': '1', 15:56:05 INFO - 'TERM': 'linux', 15:56:05 INFO - 'TMOUT': '86400', 15:56:05 INFO - 'USER': 'cltbld', 15:56:05 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1504392919.881673-574566209', 15:56:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:56:05 INFO - '_': '/tools/buildbot/bin/python'} 15:56:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:56:05 INFO - Running setup.py (path:/tmp/pip-DV5D5H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:56:05 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 15:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:56:05 INFO - Running setup.py (path:/tmp/pip-Lf6daQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:56:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:56:05 INFO - Running setup.py (path:/tmp/pip-qr7AFv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:56:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:56:05 INFO - Running setup.py (path:/tmp/pip-L2WVm9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:56:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:56:05 INFO - Running setup.py (path:/tmp/pip-av0M_o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:56:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:56:05 INFO - Running setup.py (path:/tmp/pip-F5SV0y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:56:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:56:05 INFO - Running setup.py (path:/tmp/pip-WWjIeG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:56:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:56:05 INFO - Running setup.py (path:/tmp/pip-Y5Etad-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:56:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:56:05 INFO - Running setup.py (path:/tmp/pip-Sxsf3L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:56:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:56:05 INFO - Running setup.py (path:/tmp/pip-uG2IPg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:56:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:56:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:56:06 INFO - Running setup.py (path:/tmp/pip-2ib4oC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:56:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 15:56:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:56:06 INFO - Running setup.py (path:/tmp/pip-9Lz5ey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:56:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:56:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:56:06 INFO - Running setup.py (path:/tmp/pip-SdiRSg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:56:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 15:56:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:56:06 INFO - Running setup.py (path:/tmp/pip-FTydcx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:56:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:56:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:56:06 INFO - Running setup.py (path:/tmp/pip-nA4HP7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:56:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:56:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:56:06 INFO - Running setup.py (path:/tmp/pip-ySeMmY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:56:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:56:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:56:06 INFO - Running setup.py (path:/tmp/pip-cHK3yq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:56:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:56:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:56:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:56:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:56:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:56:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:56:06 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:56:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:56:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:56:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:56:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:56:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:56:07 INFO - Downloading blessings-1.6.tar.gz 15:56:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:56:07 INFO - Installing collected packages: blessings 15:56:07 INFO - Running setup.py install for blessings 15:56:07 INFO - Successfully installed blessings 15:56:07 INFO - Cleaning up... 15:56:07 INFO - Return code: 0 15:56:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:56:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:56:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:56:08 INFO - Reading from file tmpfile_stdout 15:56:08 INFO - Current package versions: 15:56:08 INFO - argparse == 1.2.1 15:56:08 INFO - blessings == 1.6 15:56:08 INFO - blobuploader == 1.2.4 15:56:08 INFO - docopt == 0.6.1 15:56:08 INFO - functools32 == 3.2.3-2 15:56:08 INFO - jsonschema == 2.5.1 15:56:08 INFO - manifestparser == 1.1 15:56:08 INFO - mozInstall == 1.13 15:56:08 INFO - mozcrash == 1.0 15:56:08 INFO - mozdebug == 0.1 15:56:08 INFO - mozdevice == 0.51 15:56:08 INFO - mozfile == 1.2 15:56:08 INFO - mozhttpd == 0.7 15:56:08 INFO - mozinfo == 0.10 15:56:08 INFO - mozleak == 0.1 15:56:08 INFO - mozlog == 3.5 15:56:08 INFO - moznetwork == 0.27 15:56:08 INFO - mozprocess == 0.25 15:56:08 INFO - mozprofile == 0.28 15:56:08 INFO - mozrunner == 6.13 15:56:08 INFO - mozscreenshot == 0.1 15:56:08 INFO - mozsystemmonitor == 0.3 15:56:08 INFO - moztest == 0.8 15:56:08 INFO - mozversion == 1.4 15:56:08 INFO - psutil == 3.1.1 15:56:08 INFO - requests == 1.2.3 15:56:08 INFO - wsgiref == 0.1.2 15:56:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:56:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:56:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:56:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:56:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:56:08 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 0xdb21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x111ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1122090>, '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 0x1122d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x111cf90>, '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': '31acecf42b6a79ec49471d4a000001bb-1504392919.881673-574566209', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:56:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:56:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:56:08 INFO - Using env: {'DISPLAY': ':0', 15:56:08 INFO - 'HOME': '/home/cltbld', 15:56:08 INFO - 'LANG': 'en_US.UTF-8', 15:56:08 INFO - 'LANGUAGE': 'en_US:en', 15:56:08 INFO - 'LOGNAME': 'cltbld', 15:56:08 INFO - 'MAIL': '/var/mail/cltbld', 15:56:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:56:08 INFO - 'MOZ_NO_REMOTE': '1', 15:56:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:56:08 INFO - 'NO_EM_RESTART': '1', 15:56:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:56:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:56:08 INFO - 'PWD': '/builds/slave/test', 15:56:08 INFO - 'SHELL': '/bin/bash', 15:56:08 INFO - 'SHLVL': '1', 15:56:08 INFO - 'TERM': 'linux', 15:56:08 INFO - 'TMOUT': '86400', 15:56:08 INFO - 'USER': 'cltbld', 15:56:08 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1504392919.881673-574566209', 15:56:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:56:08 INFO - '_': '/tools/buildbot/bin/python'} 15:56:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:56:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:56:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:56:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:56:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:56:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:56:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:56:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:56:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:56:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:56:08 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 15:56:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:56:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:56:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:56:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:56:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 15:56:09 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:56:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:56:09 INFO - Installing collected packages: simplejson 15:56:09 INFO - Running setup.py install for simplejson 15:56:09 INFO - building 'simplejson._speedups' extension 15:56:09 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 15:56:10 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 15:56:10 INFO - Successfully installed simplejson 15:56:10 INFO - Cleaning up... 15:56:10 INFO - Return code: 0 15:56:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:56: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')]} 15:56:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:56: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')]} 15:56:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:56:10 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 0xdb21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x111ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1122090>, '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 0x1122d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x111cf90>, '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': '31acecf42b6a79ec49471d4a000001bb-1504392919.881673-574566209', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:56:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:56:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:56:10 INFO - Using env: {'DISPLAY': ':0', 15:56:10 INFO - 'HOME': '/home/cltbld', 15:56:10 INFO - 'LANG': 'en_US.UTF-8', 15:56:10 INFO - 'LANGUAGE': 'en_US:en', 15:56:10 INFO - 'LOGNAME': 'cltbld', 15:56:10 INFO - 'MAIL': '/var/mail/cltbld', 15:56:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:56:10 INFO - 'MOZ_NO_REMOTE': '1', 15:56:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:56:10 INFO - 'NO_EM_RESTART': '1', 15:56:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:56:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:56:10 INFO - 'PWD': '/builds/slave/test', 15:56:10 INFO - 'SHELL': '/bin/bash', 15:56:10 INFO - 'SHLVL': '1', 15:56:10 INFO - 'TERM': 'linux', 15:56:10 INFO - 'TMOUT': '86400', 15:56:10 INFO - 'USER': 'cltbld', 15:56:10 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1504392919.881673-574566209', 15:56:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:56:10 INFO - '_': '/tools/buildbot/bin/python'} 15:56:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:56:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:56:10 INFO - Cleaning up... 15:56:10 INFO - Return code: 0 15:56:10 INFO - Running post-action listener: _resource_record_post_action 15:56:10 INFO - Running post-action listener: _start_resource_monitoring 15:56:10 INFO - Starting resource monitoring. 15:56:10 INFO - [mozharness: 2017-09-02 22:56:10.762930Z] Finished create-virtualenv step (success) 15:56:10 INFO - [mozharness: 2017-09-02 22:56:10.763444Z] Running install step. 15:56:10 INFO - Running pre-action listener: _resource_record_pre_action 15:56:10 INFO - Running main action method: install 15:56:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:56:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:56:10 INFO - Reading from file tmpfile_stdout 15:56:10 INFO - Detecting whether we're running mozinstall >=1.0... 15:56:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:56:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:56:11 INFO - Reading from file tmpfile_stdout 15:56:11 INFO - Output received: 15:56:11 INFO - Usage: mozinstall [options] installer 15:56:11 INFO - Options: 15:56:11 INFO - -h, --help show this help message and exit 15:56:11 INFO - -d DEST, --destination=DEST 15:56:11 INFO - Directory to install application into. [default: 15:56:11 INFO - "/builds/slave/test"] 15:56:11 INFO - --app=APP Application being installed. [default: firefox] 15:56:11 INFO - mkdir: /builds/slave/test/build/application 15:56:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:56:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 15:56:27 INFO - Reading from file tmpfile_stdout 15:56:27 INFO - Output received: 15:56:27 INFO - /builds/slave/test/build/application/firefox/firefox 15:56:27 INFO - Running post-action listener: _resource_record_post_action 15:56:27 INFO - [mozharness: 2017-09-02 22:56:27.618908Z] Finished install step (success) 15:56:27 INFO - [mozharness: 2017-09-02 22:56:27.619158Z] Running setup-mitmproxy step. 15:56:27 INFO - Running pre-action listener: _resource_record_pre_action 15:56:27 INFO - Running main action method: setup_mitmproxy 15:56:27 INFO - Skipping: mitmproxy is not required 15:56:27 INFO - Running post-action listener: _resource_record_post_action 15:56:27 INFO - [mozharness: 2017-09-02 22:56:27.620265Z] Finished setup-mitmproxy step (success) 15:56:27 INFO - [mozharness: 2017-09-02 22:56:27.620540Z] Running run-tests step. 15:56:27 INFO - Running pre-action listener: _resource_record_pre_action 15:56:27 INFO - Running pre-action listener: _set_gcov_prefix 15:56:27 INFO - Running main action method: run_tests 15:56:27 WARNING - Try message not found. 15:56:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:56:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:56:27 INFO - Python 2.7.3 15:56:27 INFO - Return code: 0 15:56:27 INFO - grabbing minidump binary from tooltool 15:56:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:56:27 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 0x1122090>, '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 0x1122d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x111cf90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:56:27 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:56:27 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 15:56:27 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 15:56:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:56:27 INFO - Return code: 0 15:56:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:56:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:56:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:56:27 INFO - ENV: RUST_BACKTRACE is now full 15:56:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:56:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:56:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EForbR1USZeEN3w5edfxHw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 15:56:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EForbR1USZeEN3w5edfxHw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-014 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 15:56:27 INFO - Using env: {'DISPLAY': ':0', 15:56:27 INFO - 'HOME': '/home/cltbld', 15:56:27 INFO - 'LANG': 'en_US.UTF-8', 15:56:27 INFO - 'LANGUAGE': 'en_US:en', 15:56:27 INFO - 'LOGNAME': 'cltbld', 15:56:27 INFO - 'MAIL': '/var/mail/cltbld', 15:56:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:56:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:56:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:56:27 INFO - 'MOZ_NO_REMOTE': '1', 15:56:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:56:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:56:27 INFO - 'NO_EM_RESTART': '1', 15:56:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:56:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:56:27 INFO - 'PWD': '/builds/slave/test', 15:56:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:56:27 INFO - 'RUST_BACKTRACE': 'full', 15:56:27 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:56:27 INFO - 'SHELL': '/bin/bash', 15:56:27 INFO - 'SHLVL': '1', 15:56:27 INFO - 'TERM': 'linux', 15:56:27 INFO - 'TMOUT': '86400', 15:56:27 INFO - 'USER': 'cltbld', 15:56:27 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1504392919.881673-574566209', 15:56:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:56:27 INFO - '_': '/tools/buildbot/bin/python'} 15:56:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EForbR1USZeEN3w5edfxHw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 15:56:27 INFO - mozversion application_buildid: 20170902215941 15:56:27 INFO - mozversion application_changeset: 39e9a6b187a3f71f46d02af000ff8203abe4fe71 15:56:27 INFO - mozversion application_display_name: Nightly 15:56:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:56:27 INFO - mozversion application_name: Firefox 15:56:27 INFO - mozversion application_remotingname: firefox 15:56:27 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:56:27 INFO - mozversion application_vendor: Mozilla 15:56:27 INFO - mozversion application_version: 57.0a1 15:56:27 INFO - mozversion platform_buildid: 20170902215941 15:56:27 INFO - mozversion platform_changeset: 39e9a6b187a3f71f46d02af000ff8203abe4fe71 15:56:27 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:56:27 INFO - mozversion platform_version: 57.0a1 15:56:27 INFO - using testdate: 1504392987 15:56:27 INFO - actual date: 1504392987 15:56:27 INFO - starting webserver on 'localhost:59770' 15:56:27 INFO - SUITE-START | Running 2 tests 15:56:27 INFO - TEST-START | dromaeo_css 15:56:27 INFO - Initialising browser for dromaeo_css test... 15:56:27 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59770/getInfo.html -profile /tmp/tmpK5RbEK/profile 15:56:27 INFO - TEST-INFO | started process 14807 (/builds/slave/test/build/application/firefox/firefox http://localhost:59770/getInfo.html) 15:56:33 INFO - TEST-INFO | 14807: exit 0 15:56:33 INFO - Browser initialized. 15:56:33 INFO - Running cycle 1/1 for dromaeo_css test... 15:56:33 INFO - Using env: {'DISPLAY': ':0', 15:56:33 INFO - 'HOME': '/home/cltbld', 15:56:33 INFO - 'JSGC_DISABLE_POISONING': '1', 15:56:33 INFO - 'LANG': 'en_US.UTF-8', 15:56:33 INFO - 'LANGUAGE': 'en_US:en', 15:56:33 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 15:56:33 INFO - 'LOGNAME': 'cltbld', 15:56:33 INFO - 'MAIL': '/var/mail/cltbld', 15:56:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:56:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:56:33 INFO - 'MOZ_CRASHREPORTER': '1', 15:56:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:56:33 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 15:56:33 INFO - 'MOZ_NO_REMOTE': '1', 15:56:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:56:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:56:33 INFO - 'NO_EM_RESTART': '1', 15:56:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:56:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:56:33 INFO - 'PWD': '/builds/slave/test', 15:56:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:56:33 INFO - 'RUST_BACKTRACE': 'full', 15:56:33 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:56:33 INFO - 'SHELL': '/bin/bash', 15:56:33 INFO - 'SHLVL': '1', 15:56:33 INFO - 'TERM': 'linux', 15:56:33 INFO - 'TMOUT': '86400', 15:56:33 INFO - 'USER': 'cltbld', 15:56:33 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1504392919.881673-574566209', 15:56:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:56:33 INFO - '_': '/tools/buildbot/bin/python'} 15:56:33 INFO - TEST-INFO | started process 14991 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpK5RbEK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:56:34 INFO - PID 14991 | 15:56:34 INFO - PID 14991 | (/builds/slave/test/build/application/firefox/firefox:15043): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:56:34 INFO - PID 14991 | 15:56:44 INFO - PID 14991 | RSS: Main: 169832448 15:56:44 INFO - PID 14991 | 15:59:43 INFO - PID 14991 | Cycle 1(1): loaded http://localhost:59770/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59770/tests/dromaeo/cssquery-ext.html) 15:59:44 INFO - PID 14991 | RSS: Main: 172027904 15:59:44 INFO - PID 14991 | 16:02:46 INFO - PID 14991 | Cycle 1(1): loaded http://localhost:59770/tests/dromaeo/cssquery-ext.html (next: http://localhost:59770/tests/dromaeo/cssquery-jquery.html) 16:02:46 INFO - PID 14991 | RSS: Main: 168497152 16:02:46 INFO - PID 14991 | 16:05:48 INFO - PID 14991 | Cycle 1(1): loaded http://localhost:59770/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59770/tests/dromaeo/cssquery-mootools.html) 16:05:49 INFO - PID 14991 | RSS: Main: 170717184 16:05:49 INFO - PID 14991 | 16:08:50 INFO - PID 14991 | Cycle 1(1): loaded http://localhost:59770/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59770/tests/dromaeo/cssquery-prototype.html) 16:08:51 INFO - PID 14991 | RSS: Main: 167059456 16:08:51 INFO - PID 14991 | 16:11:54 INFO - PID 14991 | Cycle 1(1): loaded http://localhost:59770/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59770/tests/dromaeo/cssquery-yui.html) 16:11:55 INFO - PID 14991 | RSS: Main: 170672128 16:11:55 INFO - PID 14991 | 16:14:57 INFO - PID 14991 | Cycle 1(1): loaded http://localhost:59770/tests/dromaeo/cssquery-yui.html (next: http://localhost:59770/tests/dromaeo/cssquery-dojo.html) 16:14:57 INFO - PID 14991 | RSS: Main: 173293568 16:14:57 INFO - PID 14991 | 16:14:57 INFO - PID 14991 | __start_tp_report 16:14:57 INFO - PID 14991 | _x_x_mozilla_page_load 16:14:57 INFO - PID 14991 | _x_x_mozilla_page_load_details 16:14:57 INFO - PID 14991 | |i|pagename|runs| 16:14:57 INFO - PID 14991 | |0;dojo.html;3329.9833500832497;3335.999200239929;3344.046946620214;3360.260742636619;3373.207296285374;6425.742970281183;6451.870962580751;6486.221653401592;6497.545171837967;6524.739010439576;6357.809265722036;6422.197225346832;6441.838954026151;6451.483881289498;6462.579932304397;5844.561657875655;5865.912011319833;5885.646861188332;5890.440408161217;5940.287165540141;5904.350521442638;5911.5270778337845;5911.9113213301835;5933.258342707161;5970.1940238067955;5884.617499862496;5939.85150371242;5990.970045149768;5991.550633702468;6072.969635151818;5690.60165788395;5909.23179986599;5921.407859214087;5936;5997.280326360821;5653.689047102408;5772.682502462363;5886.941130588682;5918.674472903988;5946.821595352147;6353.462229769304;6427.132337134521;6433.9678301608665;6450.451711604519;6533.444657204143;6734.528582999192;6835.350641689031;6869.7595584154815;6903.447724182053;7012.859742805166;6963.40811031063;6981.79054628362;6984.266652001568;6985.965070174668;6986.930130698679;6458.838529036765;6520.250171230275;6542.084108224853;6554.9839774835455;6557.737690492327;7116.217216106224;7136.6431678415875;7143.357097861218;7251.057362542836;7252.057232559733;6601.108850305147;6674.098996635489;6743.123393958852;6859.416949559243;6907.171139463196;6841.93158068413;6926.688299026556;6944.861102777916;6945.0971373721095;6992.650367481708;6895.379415852597;6920.723171073201;6951.339622735832;6951.965240173767;6961.721531138698;6925.480588955848;6930.27232140618;6997.230304666483;7010.684519196649;7024.719011239596;5346.973265133727;5392.91910621341;5394.541463975606;5431.864203394946;5448.128299472145;4762.452317983476;4807.831725889577;4823.27650852375;4832.251001094836;4843.878903027453;5909.6158749681135;5963.850903727354;6071.119687645267;6072.36240194782;6147.0779383092895;6971.093757811452;7053.259407762213;7055.470839687044;7083.787486375417;7085.32689394517;6044.486218671374;6055.303640081359;6108.053251745898;6129.203203583595;6139.969300153471;5861.677607731531;5886.293644762571;5931.673757943355;5971.28344598651;6010.759569617167;6739.157605299338;6750.3924646782025;6756.966215168893;6757.020232066421;6760.357766012221;6877.346652068046;6999.440044796303;7060.435165186876;7061.152661680631;7063.858722825617;6728.73085076611;6735.898961515679;6801.149856267966;6802.6258555779905;6817.829554260985;6605.834854128493;6681.76613818514;6796.320367963164;6831.658417079226;6926.826829329307;7009.7897063088185;7018.894716579358;7037.472189585904;7046;7046.295370462913;6755.560888542229;6822.965885170543;6827.2490026098085;6827.48793840454;6834.179898412222;6719.966400168163;6742.6628668567355;6828.624425656637;6832.726690932307;6841.623710695761;6545.541812073109;6612.966935165294;6615.801525954229;6631.104800851823;6720.899186512304;6785.830354241183;6795.660216989229;6826.385625293748;6843.315668433316;6867.519273650796;6545.050967609765;6561.967190164019;6627.536072474881;6650.3682150195655;6659.600423974577 16:14:57 INFO - PID 14991 | |1;ext.html;782.4640121516761;833.3041910005145;863.1799790199312;1111.699841042919;1128.808102622554;30203.848980755094;39463.210735785266;41207.58792412075;41244;41377.37933930993;41064.79467602665;41222.79388603053;41320.38019429711;41423.58576414235;41477.79261103698;7571.734989275376;7731.497452665587;7735.845283094335;7744.496607720508;7749.147593764681;7554.791233402657;7689.7693069207735;7698.499597526171;7705.499142555744;7710.383169346439;7125.928740712604;7355.595442250701;7761;7763.961180194091;7764.3788496920115;7665.808354791119;7710.884336734954;7726.266004729542;7727.072751269883;7727.227277272256;7600.619969001527;7672.232776722283;7686.615669216572;7687.461877668566;7700.422468314843;36264.63735362639;36515.817420912725;36541.45187822185;36629.450558241646;36644.81677591595;3509.7543171977973;3542.220711443478;3555.928881422357;3560.2523470071055;3560.964390356115;30501;30564.694353056406;30665.080047598607;30666.62000209996;30667.69332306693;4831.830885918976;4925.9409227016;5011.749412529359;5031.899362012739;5115.744212789383;193068;195518;196156;197796;198553;47381.763091185014;47668;47706;47737.522624774;47829;50291.245631315556;50529;50635.49364506381;50667.23999140016;50667.493325067015;15610.45363412275;15847.366105355888;15872.52382428529;15893.682126357407;15911.204439777965;13036.869631303754;13049.934750326378;13081.672958175932;13098.345082745825;13115.737685246433;12596.307203103917;13806.792898106536;14026.298685065705;14031.859681403055;14253.78619320711;4923.6952207665;5732.254806875079;5748.425157484218;5767.36558978512;6016.067509536029;976.2043934193752;1005.2912696548915;1007.219404961161;1015.3095894791466;1016.2124353625999;23089.53820923572;27974.86012569924;28338.858305708753;29119.41761164765;29303.706962930522;1085.8642669666292;1088.6516314779194;1093.185576745314;1095.1567293184362;1098.8132017557034;11816.46825892837;12102.273863568214;12152.57465988704;12179.330136842558;12197.573084942162;248130;250015;250015;251302;252019;51420.22869656958;51725;51733.22400164;51822;51858.48141518612;1379.5861241627472;1432.6776475293184;1450.579331993731;1451.6153219396867;1465.7068586282787;21751;21942;22423;22457.887710561998;22480.66279005849;48134;49027.509724902295;49456.50543494519;49495;49614.50385496099;210076;211468;211708;211991;220394;36029;36173.638263617024;36474;36561;36667.26665466622;41869.1626167481;44994.550054500345;45213.773931130134;45309.546904530536;45457.77271113623;33333;33521.66478335185;33734.83132584322;33755.32489350248;33912.83043584865;32837.17907052343;32921.83539082289;33130.834345828116;33508.1622959428;33539.83230083834;37102.25795484129;37406.438903415925;37528.81235593805;37766;37974;32290.677093228765;32511;32661.836690816395;32953.83523082369;33137.83431082829;23375;24206.15278465245;24571.8771406149;25052;25351.36621584475 16:14:57 INFO - PID 14991 | |2;jquery.html;554.2268535393126;561.8370672504974;571.7284289962271;584.1558947321122;585.8037557418266;22272.109115635376;22931;22954.770452295474;23013;23555.528889422243;24523.75476245237;25287.87356063222;25322.87338563309;25401.61897571538;25414.872925635347;6294.244690637107;6509.674516274179;6651.301613330603;6655.567388119781;6655.767048153316;6437.613743175424;6528.151340325775;6529.608223506581;6533.05270735743;6535.444487218592;6475.190601174853;6478.319776423478;6482.416582507573;6489.772857949973;6489.967550162242;6468.3208263132165;6490.058941453486;6510.023496475519;6510.218773747133;6515.674216289167;6004.939950600526;6012.128241405016;6018.067199584071;6018.127371531104;6033.698315084228;28015.159545213675;28557.57163642547;29518.671659775147;29738;29814.55278170829;2050.5796311756053;2071.8446116541318;2071.989640051805;2076.3355726167633;2084.749830020392;19060.61878762431;19722.80277197224;19745.802541974685;19750.506237344038;19764.50588735279;2282.3609389371004;2314.1437668062927;2341.6019276722827;2350.424146084203;2398.040783686522;130984;135855;139318;139529;139530;13726.65683357904;14704.26478676062;14764.187969661556;14999.250037498081;15375.61560960985;22955.196568120034;23018.194363197206;23036.4240893979;23041.42396440069;23063.42341441444;10166.390016599027;10286.074253317087;10299.691009269734;10387.68836934893;10451.634192803216;8451.1548845115;8792.47245165292;9006.729798106067;9369.672061477815;9685.515724213761;8944.955275223712;9146.81706365869;9215.953920230357;9252.7686807829;9279.443233406017;2674.7191544887505;2702.9864850676013;2713.8914443422436;2733.72662733725;2767.972320276812;959.8944116147218;976.5605477535138;981.249344251648;988.4415305352453;993.6671215143008;19397.709034364496;19533;19618.509537261398;20042.298519551747;23432.64851027236;1018.4347687033768;1054.1830081686753;1059.655611926127;1059.782744537368;1061.792950374685;10721.35671859691;11435.656930291938;13050.673733156556;13456.25990570528;13706.725865482835;519990;541205.4698632486;545056;562940;564016;117514;117532;120343;121879;122766;1212.345333519907;1230.833837431953;1241.6647505173732;1257.4592925042136;1258.3393718297784;20931.16275348969;21068.47328816792;21294.78705212928;21362.679559806926;21473.67789483128;59510;60768.39231607627;61647.691761540904;61739.69130154321;63105.68447157735;72976.27023729908;73107;73552;73562;73787.63106184435;11863.466144023367;12193;13970.650733731738;14589.27053647292;14870.776938345716;22604.321870343916;22689.205877794197;22754.886225568767;22784.31647050591;23252.3024309271;18148.274069037092;18578.535536611693;18608.16263268129;18761.624767504847;18764.530886727942;16380.262888169822;16388.83611163873;16522.83477165261;16821;16882.24029918681;18592.25630974746;18632.254709811456;18653.347132850286;18785;18805.529861753017;14206.07660502064;14322.928385358007;14339.354729037426;14498.202598856742;14536.636584085483;18058.909705451388;18251.634967300844;18280.45158645243;18325.633487329913;18442.35451759182 16:14:57 INFO - PID 14991 | |3;mootools.html;1286.8327117474728;1321.2072756346192;1337.5051231044504;1344.959651210464;1353.377446374667;14677;15290.31193596288;15397.384104635801;15409.383624655;15421;15382.769258461103;15889.761653575206;15924.76112858308;15932.522024339289;15935.681286374265;2786.5262905306095;2834.829910205384;2834.9716502834913;2835.3903910659205;2836;2833.3766571354267;2946.646402431711;2949.4985852405034;2951;2951.483490389184;2768.4463107378506;2825.22306365749;2833.4333133373307;2842.6020357149914;2873.224229458045;2788.177487641151;2808.354078561932;2819.2669905824428;2821.3087793490727;2825.9576106358422;2697.1908427471876;2739.369944912661;2757.214193954733;2773.195773225762;2779.2496026072845;14816.555503334917;15155.62110947224;15162.696746065018;15192.468263610832;15249.61875953099;8213.712520061828;8444.746657600283;8470.407071504997;8472.025717042558;8493.575321233913;5344.812931547377;5453.536449401806;5528.612997090206;5606.271184745998;5631.690257035862;1928.4985903665008;1932.5265309999;1936.9612607747906;1957.3853731357947;1998.69020301852;26492.337691557674;26851.86574067117;26900;26925.32686682829;26927.32681682954;7033.8241543960785;7310.268973102648;7456.40348772097;7656.119546252141;7714.228577142241;16359.67280654404;16418.507444776675;16430.507084787238;16475.176241188132;16477.176141192893;7899.0126234220725;8015.118336983044;8047.396445266511;8056.315213206943;8078.151794061657;7361.852762944711;7416.369608583331;7482.588457634883;7520.736774212985;7532.849343013109;5239.921401178985;5356.464353564613;5431.076716958127;5450.4549545045975;5477.863053423696;1579.2498563182396;1589.308650736933;1589.4436947068434;1617.9029258244543;1618.919054047293;886.8137691084816;915.7802127489355;921.8294615496154;933.8179055084329;934.238595544629;7836.764897053097;7932.524048557105;7966.920330796734;7974.401919856034;8028.397870159644;726.5287792220689;728.8651599454118;738.0921466596117;742.7474658616096;751.6880494594791;4914.533119353656;5167.250748641426;5268.025415298182;5338.786448542092;5755.7122143893475;21379;21505.462363441038;22003.669944950838;22364.99357528915;22400.775992240197;21590.352289431343;21958.670619940713;22251.221207257993;22371.32886013422;22377.776222237568;11217.439128043728;11488.597899073493;11596.594119205956;11612.12909031809;11656.592019279284;8549.572521373782;8692.39153259291;8735.039145693841;8785.824283514166;8816.382853200472;18488.16803243884;18572.44282671522;18787.436376908714;18844.152013159714;18889.527761806065;19317.903410482857;19347;19347.129379177688;19403.320883769;19539.120739566468;11011.724706882393;11077.11383089367;11179.60871369498;11182.832257515982;11184.105271578092;13854.861451385357;14036.228007459687;14041.017128800886;14059.578212653636;14062.78905816434;11258.718532036764;11308.43457827089;11343.20597558163;11375.772484550098;11622.6513204604;11053.392063436266;11129.833052504056;11173.55305787792;11398.886011139783;11494.94252528732;9707.805843883225;9960.701178964642;9963.651272205729;9997.900020999989;10068.69793906184;7472.589007604634;7673.654685539276;7842.725504607311;7858.764237072897;7882.330001949669;7188;7241.855162896818;7301.926980730337;7342.9632851835395;7358.300961408658 16:14:57 INFO - PID 14991 | |4;prototype.html;509.3378607809846;515.2503107977891;528.1813189556188;535.5126834580533;538.3943064052941;6305.148804911341;6383.234011918565;6407.647579383132;6408.295087540373;6418.518611104162;6213.813585592439;6222.160008398865;6251.2498500180045;6272.905906411407;6297.275813281474;5113.079645663779;5163.586913046947;5170.405403378603;5173.689578625294;5196.740162991854;4834.444038935515;5117.820876269331;5217.34783152106;5230.398504172012;5236.738163091849;4913.778879950393;4940.777665005084;4964.900701985976;4977.900441991158;4979.975100124494;4918.401519506175;4986.725730084844;5002.9493806300725;5022.874428139289;5040.571551418134;4344.174606824725;4458.308962110878;4483.50681425043;4486.4616246050355;4514.164879497303;6033;6105.481034112106;6116.663583502906;6131.448169664707;6163.537734669918;5691.573132015115;5694.544436445074;5714.885702285973;5715.685637289947;5727.9427205727825;6444.420002199778;6601.63690996995;6643.534952553275;6660.2340730816095;6711.832204194934;4884.29177769225;4896.510348965111;4913.950860491385;4928.359313289286;4946.455889852114;6603.867922641521;6617.239017512999;6682.899756503656;6952.374286314205;6996.930030699678;4954.752262386866;4974.403071631355;4999.350084488993;5003.5997120230295;5043.344365232496;5028.823991160292;5068.366454193226;5073.441921388644;5087.974560127176;5122.257272695513;5639.295088113986;5664.49019588239;5688.317401911797;5693.857653558612;5732.226149469851;6651.600903945779;6672.899906501407;6691.130153080068;6700.262971073178;6779.186497620317;1766.938157164493;1771.5128339706425;1774.4587900690412;1779.4429873860372;1785.7589225454396;1160.5995931403652;1210.2556927489532;1219.951201951912;1220.7924652809045;1226.1907141286708;5836.533077353886;5891.440313170242;5917.201177841022;5934.495567876693;5999.700014999233;6720.529562930548;6742;6770.8645827084165;6819.283975182534;6821.829454263683;5881.264841894763;5881.41185881417;5904.852378690567;5935.436133567304;5978.940210597925;3565.286942611436;3569.5894972078545;3619;3620.8913732588067;3626.2384899170943;6568.573042752206;6587.703553340111;6592.538522303393;6615.206175258903;6619.900701489481;6991.7902462926195;7002.159740831133;7026.824329391806;7038.859222815515;7111.359977602041;6114.877702445926;6499.155109835691;6539.084528165966;6607.702653380609;6611.867762644816;6680.432163266177;6773.458123350219;6778.42383397397;6796.93203067963;6798.796036118924;6375.936240637534;6650.434713049445;6690.498212634169;6695.296993815579;6709.705788295397;6399.168108145911;6500.934990650222;6517.73929042833;6536.8365790855605;6590.209174899042;5002.974985125051;5089.694618322913;5102.744862756773;5102.974485127551;5118.74406279692;6532.771353002812;6622.933770662232;6707.960266158753;6948.270431604811;6952.860942781217;6522.380373864476;6533.18335208099;6551.181102362205;6575.408213260829;6611.710716410254;6469.8706025880165;6532.05285233648;6532.673366331759;6595.17399491524;6658.300878407697;6469.417752402306;6532.673366331759;6556.18047744032;6571.96714016446;6580.276169621242;6651.838152600328;6676;6683.398494135551;6732.562383445061;6776.86446271062;6344.9048264277;6419.977707022273;6446.5165112615805;6447.70985305653;6515.250746164252 16:14:57 INFO - PID 14991 | |5;yui.html;905.275779376499;910.4309806371017;929.1637526226391;929.4098247612768;934.1825902335456;17603.647927041453;18742.53143671409;18787.906060469697;18815.247390104378;18902.432927012178;16865.07242101684;18192.818071819278;20694.379168624928;20705.482362940933;20861.582768344622;986.1666891476708;997.7954519323521;997.8154041502308;1002.6290272599113;1004.0812656419404;948.393028461785;995.3480470291934;1003.7992401519689;1005.7737009172951;1005.8239808033602;1050.7163065972184;1051.8842927277992;1053.0943388685723;1053.346924906559;1054.2514814481726;1050.1074087026043;1050.3120456101267;1052.0478966535297;1052.952617132227;1059.729768908927;773.8645736996003;773.9187385324516;774.349546381037;775.767269819052;781.3436713160972;16896.408625698165;17309.91345043267;17501.56246093845;17791.288348466045;17936;19864.80135198644;20359;20686.379408617617;20768.896155519127;20797.376078717512;16255.431059912846;16957.830421695748;17020.319187232497;17033.7444938326;17093.572660683458;3717.20080182762;3745.8501659933568;3747.306748251555;3747.7376583639157;3752.3058234226755;124481;125906.99999999908;128070;131372;132499;16829.83170168307;17431.47705568835;17551.64896702059;17626.29494820193;17628.20673069715;29938;31079.84460077685;31427.685723142935;31566.36867262642;31590.842045790083;8877.422967507091;8916.955415223012;8919.375643705009;8951.507667078373;8967.237784788365;3893.7079719021185;4192.098698779716;4244.214820258262;4255.340422234559;4262.744235345889;5266.131088370376;5399.83800485986;5400.540954018874;5426.511613954763;5439.809606663827;1105.6406667832987;1127.6109742139113;1144.376314908377;1147.3345459633392;1158.2818652435376;694.6318451220861;712.2556928010242;718.8418547919449;719.8416348403343;738.2027410396759;10871.508993821;12110.75778484443;13134.60596182116;13286.867131328756;13621.318934053257;702.2310569925922;709.4218212157075;718.0593422616389;725.9528130671489;740.3484933258698;5898.439648233411;6120.14317995481;6194.907076393858;6228.408301211378;6238.532110091761;104321;105598;109594.62497190226;110533;110662;94975;96075;96850;99743;99951.50024249832;87654;88225;88936.11063889408;90130.54934725416;90982.54508727413;12401;12642.55751048709;12756.653138244485;12784.232946023269;12794.872051279368;39532.2093558133;41147.58852411557;41611;41726.37410438906;42138.36792448177;50892.98214035772;53015;53028.204576930606;54505.72747136239;54928.450715492334;17236.655266894842;17413.564660883072;17419.129043548026;17583.560410989317;17595.64808703793;20776.58446831085;20780.1687932481;20858;20908.05913733855;21010.68483972711;17813.46559603214;18009.369672061413;18038;18080.367187148386;18196.27214911442;17976.82023179804;18118.5470363242;18277.177527011052;18297;18419.07904604791;16156.11141387235;16262.186890655183;16336.183190840648;16422.917885410498;16813.41153059637;12486.188397754117;13370.997175211704;13496.932515337361;13714.794278085637;13794.517191898236;13667.453301867814;14177.078489898124;14189;14248.857511424752;14294.857051429353 16:14:57 INFO - PID 14991 | __end_tp_report 16:14:57 INFO - PID 14991 | __start_cc_report 16:14:57 INFO - PID 14991 | _x_x_mozilla_cycle_collect,349 16:14:57 INFO - PID 14991 | __end_cc_report 16:14:57 INFO - PID 14991 | __startTimestamp1504394097510__endTimestamp 16:14:57 INFO - PID 14991 | 16:14:57 INFO - PID 14991 | ------- Summary: start ------- 16:14:57 INFO - PID 14991 | Number of tests: 6 16:14:57 INFO - PID 14991 | 16:14:57 INFO - PID 14991 | [#0] dojo.html Cycles:165 Average:6384.87 Median:6627.54 stddev:761.80 (11.5%) stddev-sans-first:725.47 16:14:57 INFO - PID 14991 | Values: 3330.0 3336.0 3344.0 3360.3 3373.2 6425.7 6451.9 6486.2 6497.5 6524.7 6357.8 6422.2 6441.8 6451.5 6462.6 5844.6 5865.9 5885.6 5890.4 5940.3 5904.4 5911.5 5911.9 5933.3 5970.2 5884.6 5939.9 5991.0 5991.6 6073.0 5690.6 5909.2 5921.4 5936.0 5997.3 5653.7 5772.7 5886.9 5918.7 5946.8 6353.5 6427.1 6434.0 6450.5 6533.4 6734.5 6835.4 6869.8 6903.4 7012.9 6963.4 6981.8 6984.3 6986.0 6986.9 6458.8 6520.3 6542.1 6555.0 6557.7 7116.2 7136.6 7143.4 7251.1 7252.1 6601.1 6674.1 6743.1 6859.4 6907.2 6841.9 6926.7 6944.9 6945.1 6992.7 6895.4 6920.7 6951.3 6952.0 6961.7 6925.5 6930.3 6997.2 7010.7 7024.7 5347.0 5392.9 5394.5 5431.9 5448.1 4762.5 4807.8 4823.3 4832.3 4843.9 5909.6 5963.9 6071.1 6072.4 6147.1 6971.1 7053.3 7055.5 7083.8 7085.3 6044.5 6055.3 6108.1 6129.2 6140.0 5861.7 5886.3 5931.7 5971.3 6010.8 6739.2 6750.4 6757.0 6757.0 6760.4 6877.3 6999.4 7060.4 7061.2 7063.9 6728.7 6735.9 6801.1 6802.6 6817.8 6605.8 6681.8 6796.3 6831.7 6926.8 7009.8 7018.9 7037.5 7046.0 7046.3 6755.6 6823.0 6827.2 6827.5 6834.2 6720.0 6742.7 6828.6 6832.7 6841.6 6545.5 6613.0 6615.8 6631.1 6720.9 6785.8 6795.7 6826.4 6843.3 6867.5 6545.1 6562.0 6627.5 6650.4 6659.6 16:14:57 INFO - PID 14991 | 16:14:57 INFO - PID 14991 | [#1] ext.html Cycles:180 Average:39163.63 Median:3560.61 stddev:57362.33 (1611.0%) stddev-sans-first:57450.86 16:14:57 INFO - PID 14991 | Values: 782.5 833.3 863.2 1111.7 1128.8 30203.8 39463.2 41207.6 41244.0 41377.4 41064.8 41222.8 41320.4 41423.6 41477.8 7571.7 7731.5 7735.8 7744.5 7749.1 7554.8 7689.8 7698.5 7705.5 7710.4 7125.9 7355.6 7761.0 7764.0 7764.4 7665.8 7710.9 7726.3 7727.1 7727.2 7600.6 7672.2 7686.6 7687.5 7700.4 36264.6 36515.8 36541.5 36629.5 36644.8 3509.8 3542.2 3555.9 3560.3 3561.0 30501.0 30564.7 30665.1 30666.6 30667.7 4831.8 4925.9 5011.7 5031.9 5115.7 193068.0 195518.0 196156.0 197796.0 198553.0 47381.8 47668.0 47706.0 47737.5 47829.0 50291.2 50529.0 50635.5 50667.2 50667.5 15610.5 15847.4 15872.5 15893.7 15911.2 13036.9 13049.9 13081.7 13098.3 13115.7 12596.3 13806.8 14026.3 14031.9 14253.8 4923.7 5732.3 5748.4 5767.4 6016.1 976.2 1005.3 1007.2 1015.3 1016.2 23089.5 27974.9 28338.9 29119.4 29303.7 1085.9 1088.7 1093.2 1095.2 1098.8 11816.5 12102.3 12152.6 12179.3 12197.6 248130.0 250015.0 250015.0 251302.0 252019.0 51420.2 51725.0 51733.2 51822.0 51858.5 1379.6 1432.7 1450.6 1451.6 1465.7 21751.0 21942.0 22423.0 22457.9 22480.7 48134.0 49027.5 49456.5 49495.0 49614.5 210076.0 211468.0 211708.0 211991.0 220394.0 36029.0 36173.6 36474.0 36561.0 36667.3 41869.2 44994.6 45213.8 45309.5 45457.8 33333.0 33521.7 33734.8 33755.3 33912.8 32837.2 32921.8 33130.8 33508.2 33539.8 37102.3 37406.4 37528.8 37766.0 37974.0 32290.7 32511.0 32661.8 32953.8 33137.8 23375.0 24206.2 24571.9 25052.0 25351.4 16:14:57 INFO - PID 14991 | 16:14:57 INFO - PID 14991 | [#2] jquery.html Cycles:180 Average:36710.34 Median:22942.89 stddev:91510.86 (398.9%) stddev-sans-first:91727.31 16:14:57 INFO - PID 14991 | Values: 554.2 561.8 571.7 584.2 585.8 22272.1 22931.0 22954.8 23013.0 23555.5 24523.8 25287.9 25322.9 25401.6 25414.9 6294.2 6509.7 6651.3 6655.6 6655.8 6437.6 6528.2 6529.6 6533.1 6535.4 6475.2 6478.3 6482.4 6489.8 6490.0 6468.3 6490.1 6510.0 6510.2 6515.7 6004.9 6012.1 6018.1 6018.1 6033.7 28015.2 28557.6 29518.7 29738.0 29814.6 2050.6 2071.8 2072.0 2076.3 2084.7 19060.6 19722.8 19745.8 19750.5 19764.5 2282.4 2314.1 2341.6 2350.4 2398.0 130984.0 135855.0 139318.0 139529.0 139530.0 13726.7 14704.3 14764.2 14999.3 15375.6 22955.2 23018.2 23036.4 23041.4 23063.4 10166.4 10286.1 10299.7 10387.7 10451.6 8451.2 8792.5 9006.7 9369.7 9685.5 8945.0 9146.8 9216.0 9252.8 9279.4 2674.7 2703.0 2713.9 2733.7 2768.0 959.9 976.6 981.2 988.4 993.7 19397.7 19533.0 19618.5 20042.3 23432.6 1018.4 1054.2 1059.7 1059.8 1061.8 10721.4 11435.7 13050.7 13456.3 13706.7 519990.0 541205.5 545056.0 562940.0 564016.0 117514.0 117532.0 120343.0 121879.0 122766.0 1212.3 1230.8 1241.7 1257.5 1258.3 20931.2 21068.5 21294.8 21362.7 21473.7 59510.0 60768.4 61647.7 61739.7 63105.7 72976.3 73107.0 73552.0 73562.0 73787.6 11863.5 12193.0 13970.7 14589.3 14870.8 22604.3 22689.2 22754.9 22784.3 23252.3 18148.3 18578.5 18608.2 18761.6 18764.5 16380.3 16388.8 16522.8 16821.0 16882.2 18592.3 18632.3 18653.3 18785.0 18805.5 14206.1 14322.9 14339.4 14498.2 14536.6 18058.9 18251.6 18280.5 18325.6 18442.4 16:14:57 INFO - PID 14991 | 16:14:57 INFO - PID 14991 | [#3] mootools.html Cycles:180 Average:9463.67 Median:2776.22 stddev:6718.00 (242.0%) stddev-sans-first:6708.75 16:14:57 INFO - PID 14991 | Values: 1286.8 1321.2 1337.5 1345.0 1353.4 14677.0 15290.3 15397.4 15409.4 15421.0 15382.8 15889.8 15924.8 15932.5 15935.7 2786.5 2834.8 2835.0 2835.4 2836.0 2833.4 2946.6 2949.5 2951.0 2951.5 2768.4 2825.2 2833.4 2842.6 2873.2 2788.2 2808.4 2819.3 2821.3 2826.0 2697.2 2739.4 2757.2 2773.2 2779.2 14816.6 15155.6 15162.7 15192.5 15249.6 8213.7 8444.7 8470.4 8472.0 8493.6 5344.8 5453.5 5528.6 5606.3 5631.7 1928.5 1932.5 1937.0 1957.4 1998.7 26492.3 26851.9 26900.0 26925.3 26927.3 7033.8 7310.3 7456.4 7656.1 7714.2 16359.7 16418.5 16430.5 16475.2 16477.2 7899.0 8015.1 8047.4 8056.3 8078.2 7361.9 7416.4 7482.6 7520.7 7532.8 5239.9 5356.5 5431.1 5450.5 5477.9 1579.2 1589.3 1589.4 1617.9 1618.9 886.8 915.8 921.8 933.8 934.2 7836.8 7932.5 7966.9 7974.4 8028.4 726.5 728.9 738.1 742.7 751.7 4914.5 5167.3 5268.0 5338.8 5755.7 21379.0 21505.5 22003.7 22365.0 22400.8 21590.4 21958.7 22251.2 22371.3 22377.8 11217.4 11488.6 11596.6 11612.1 11656.6 8549.6 8692.4 8735.0 8785.8 8816.4 18488.2 18572.4 18787.4 18844.2 18889.5 19317.9 19347.0 19347.1 19403.3 19539.1 11011.7 11077.1 11179.6 11182.8 11184.1 13854.9 14036.2 14041.0 14059.6 14062.8 11258.7 11308.4 11343.2 11375.8 11622.7 11053.4 11129.8 11173.6 11398.9 11494.9 9707.8 9960.7 9963.7 9997.9 10068.7 7472.6 7673.7 7842.7 7858.8 7882.3 7188.0 7241.9 7301.9 7343.0 7358.3 16:14:57 INFO - PID 14991 | 16:14:57 INFO - PID 14991 | [#4] prototype.html Cycles:180 Average:5562.72 Median:6188.68 stddev:1560.75 (25.2%) stddev-sans-first:1518.34 16:14:57 INFO - PID 14991 | Values: 509.3 515.3 528.2 535.5 538.4 6305.1 6383.2 6407.6 6408.3 6418.5 6213.8 6222.2 6251.2 6272.9 6297.3 5113.1 5163.6 5170.4 5173.7 5196.7 4834.4 5117.8 5217.3 5230.4 5236.7 4913.8 4940.8 4964.9 4977.9 4980.0 4918.4 4986.7 5002.9 5022.9 5040.6 4344.2 4458.3 4483.5 4486.5 4514.2 6033.0 6105.5 6116.7 6131.4 6163.5 5691.6 5694.5 5714.9 5715.7 5727.9 6444.4 6601.6 6643.5 6660.2 6711.8 4884.3 4896.5 4914.0 4928.4 4946.5 6603.9 6617.2 6682.9 6952.4 6996.9 4954.8 4974.4 4999.4 5003.6 5043.3 5028.8 5068.4 5073.4 5088.0 5122.3 5639.3 5664.5 5688.3 5693.9 5732.2 6651.6 6672.9 6691.1 6700.3 6779.2 1766.9 1771.5 1774.5 1779.4 1785.8 1160.6 1210.3 1220.0 1220.8 1226.2 5836.5 5891.4 5917.2 5934.5 5999.7 6720.5 6742.0 6770.9 6819.3 6821.8 5881.3 5881.4 5904.9 5935.4 5978.9 3565.3 3569.6 3619.0 3620.9 3626.2 6568.6 6587.7 6592.5 6615.2 6619.9 6991.8 7002.2 7026.8 7038.9 7111.4 6114.9 6499.2 6539.1 6607.7 6611.9 6680.4 6773.5 6778.4 6796.9 6798.8 6375.9 6650.4 6690.5 6695.3 6709.7 6399.2 6500.9 6517.7 6536.8 6590.2 5003.0 5089.7 5102.7 5103.0 5118.7 6532.8 6622.9 6708.0 6948.3 6952.9 6522.4 6533.2 6551.2 6575.4 6611.7 6469.9 6532.1 6532.7 6595.2 6658.3 6469.4 6532.7 6556.2 6572.0 6580.3 6651.8 6676.0 6683.4 6732.6 6776.9 6344.9 6420.0 6446.5 6447.7 6515.3 16:14:57 INFO - PID 14991 | 16:14:57 INFO - PID 14991 | [#5] yui.html Cycles:180 Average:23324.86 Median:18858.84 stddev:31798.71 (168.6%) stddev-sans-first:31843.35 16:14:57 INFO - PID 14991 | Values: 905.3 910.4 929.2 929.4 934.2 17603.6 18742.5 18787.9 18815.2 18902.4 16865.1 18192.8 20694.4 20705.5 20861.6 986.2 997.8 997.8 1002.6 1004.1 948.4 995.3 1003.8 1005.8 1005.8 1050.7 1051.9 1053.1 1053.3 1054.3 1050.1 1050.3 1052.0 1053.0 1059.7 773.9 773.9 774.3 775.8 781.3 16896.4 17309.9 17501.6 17791.3 17936.0 19864.8 20359.0 20686.4 20768.9 20797.4 16255.4 16957.8 17020.3 17033.7 17093.6 3717.2 3745.9 3747.3 3747.7 3752.3 124481.0 125907.0 128070.0 131372.0 132499.0 16829.8 17431.5 17551.6 17626.3 17628.2 29938.0 31079.8 31427.7 31566.4 31590.8 8877.4 8917.0 8919.4 8951.5 8967.2 3893.7 4192.1 4244.2 4255.3 4262.7 5266.1 5399.8 5400.5 5426.5 5439.8 1105.6 1127.6 1144.4 1147.3 1158.3 694.6 712.3 718.8 719.8 738.2 10871.5 12110.8 13134.6 13286.9 13621.3 702.2 709.4 718.1 726.0 740.3 5898.4 6120.1 6194.9 6228.4 6238.5 104321.0 105598.0 109594.6 110533.0 110662.0 94975.0 96075.0 96850.0 99743.0 99951.5 87654.0 88225.0 88936.1 90130.5 90982.5 12401.0 12642.6 12756.7 12784.2 12794.9 39532.2 41147.6 41611.0 41726.4 42138.4 50893.0 53015.0 53028.2 54505.7 54928.5 17236.7 17413.6 17419.1 17583.6 17595.6 20776.6 20780.2 20858.0 20908.1 21010.7 17813.5 18009.4 18038.0 18080.4 18196.3 17976.8 18118.5 18277.2 18297.0 18419.1 16156.1 16262.2 16336.2 16422.9 16813.4 12486.2 13371.0 13496.9 13714.8 13794.5 13667.5 14177.1 14189.0 14248.9 14294.9 16:14:57 INFO - PID 14991 | -------- Summary: end -------- 16:14:57 INFO - PID 14991 | 16:14:58 INFO - TEST-INFO | 14991: exit 0 16:14:58 INFO - TEST-OK | dromaeo_css | took 1110209ms 16:14:58 INFO - TEST-START | kraken 16:14:58 INFO - Initialising browser for kraken test... 16:14:58 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59770/getInfo.html -profile /tmp/tmp4JVwRG/profile 16:14:58 INFO - TEST-INFO | started process 15361 (/builds/slave/test/build/application/firefox/firefox http://localhost:59770/getInfo.html) 16:15:03 INFO - TEST-INFO | 15361: exit 0 16:15:03 INFO - Browser initialized. 16:15:03 INFO - Running cycle 1/1 for kraken test... 16:15:03 INFO - Using env: {'DISPLAY': ':0', 16:15:03 INFO - 'HOME': '/home/cltbld', 16:15:03 INFO - 'JSGC_DISABLE_POISONING': '1', 16:15:03 INFO - 'LANG': 'en_US.UTF-8', 16:15:03 INFO - 'LANGUAGE': 'en_US:en', 16:15:03 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 16:15:03 INFO - 'LOGNAME': 'cltbld', 16:15:03 INFO - 'MAIL': '/var/mail/cltbld', 16:15:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:15:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:15:03 INFO - 'MOZ_CRASHREPORTER': '1', 16:15:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:15:03 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 16:15:03 INFO - 'MOZ_NO_REMOTE': '1', 16:15:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:15:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:15:03 INFO - 'NO_EM_RESTART': '1', 16:15:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:15:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:15:03 INFO - 'PWD': '/builds/slave/test', 16:15:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:15:03 INFO - 'RUST_BACKTRACE': 'full', 16:15:03 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:15:03 INFO - 'SHELL': '/bin/bash', 16:15:03 INFO - 'SHLVL': '1', 16:15:03 INFO - 'TERM': 'linux', 16:15:03 INFO - 'TMOUT': '86400', 16:15:03 INFO - 'USER': 'cltbld', 16:15:03 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1504392919.881673-574566209', 16:15:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:15:03 INFO - '_': '/tools/buildbot/bin/python'} 16:15:03 INFO - TEST-INFO | started process 15543 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4JVwRG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:15:04 INFO - PID 15543 | 16:15:04 INFO - PID 15543 | (/builds/slave/test/build/application/firefox/firefox:15595): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:15:04 INFO - PID 15543 | 16:15:14 INFO - PID 15543 | RSS: Main: 170659840 16:15:14 INFO - PID 15543 | 16:15:17 INFO - PID 15543 | Cycle 1(1): loaded http://localhost:59770/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59770/tests/kraken/driver.html?testName=audio-beat-detection) 16:15:17 INFO - PID 15543 | RSS: Main: 175419392 16:15:17 INFO - PID 15543 | 16:15:20 INFO - PID 15543 | Cycle 1(1): loaded http://localhost:59770/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59770/tests/kraken/driver.html?testName=audio-dft) 16:15:21 INFO - PID 15543 | RSS: Main: 179642368 16:15:21 INFO - PID 15543 | 16:15:24 INFO - PID 15543 | Cycle 1(1): loaded http://localhost:59770/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59770/tests/kraken/driver.html?testName=audio-fft) 16:15:24 INFO - PID 15543 | RSS: Main: 172924928 16:15:24 INFO - PID 15543 | 16:15:26 INFO - PID 15543 | Cycle 1(1): loaded http://localhost:59770/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59770/tests/kraken/driver.html?testName=audio-oscillator) 16:15:27 INFO - PID 15543 | RSS: Main: 173518848 16:15:27 INFO - PID 15543 | 16:15:29 INFO - PID 15543 | Cycle 1(1): loaded http://localhost:59770/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59770/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:15:30 INFO - PID 15543 | RSS: Main: 173662208 16:15:30 INFO - PID 15543 | 16:15:33 INFO - PID 15543 | Cycle 1(1): loaded http://localhost:59770/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59770/tests/kraken/driver.html?testName=imaging-darkroom) 16:15:34 INFO - PID 15543 | RSS: Main: 174927872 16:15:34 INFO - PID 15543 | 16:15:37 INFO - PID 15543 | Cycle 1(1): loaded http://localhost:59770/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59770/tests/kraken/driver.html?testName=imaging-desaturate) 16:15:38 INFO - PID 15543 | RSS: Main: 175136768 16:15:38 INFO - PID 15543 | 16:15:41 INFO - PID 15543 | Cycle 1(1): loaded http://localhost:59770/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59770/tests/kraken/driver.html?testName=json-parse-financial) 16:15:41 INFO - PID 15543 | RSS: Main: 175157248 16:15:41 INFO - PID 15543 | 16:15:43 INFO - PID 15543 | Cycle 1(1): loaded http://localhost:59770/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59770/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:15:43 INFO - PID 15543 | RSS: Main: 174915584 16:15:43 INFO - PID 15543 | 16:15:45 INFO - PID 15543 | Cycle 1(1): loaded http://localhost:59770/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59770/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:15:46 INFO - PID 15543 | RSS: Main: 174649344 16:15:46 INFO - PID 15543 | 16:15:48 INFO - PID 15543 | Cycle 1(1): loaded http://localhost:59770/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59770/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:15:48 INFO - PID 15543 | RSS: Main: 171278336 16:15:48 INFO - PID 15543 | 16:15:51 INFO - PID 15543 | Cycle 1(1): loaded http://localhost:59770/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59770/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:15:52 INFO - PID 15543 | RSS: Main: 171225088 16:15:52 INFO - PID 15543 | 16:15:55 INFO - PID 15543 | Cycle 1(1): loaded http://localhost:59770/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59770/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:15:55 INFO - PID 15543 | RSS: Main: 171982848 16:15:55 INFO - PID 15543 | 16:15:57 INFO - PID 15543 | Cycle 1(1): loaded http://localhost:59770/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59770/tests/kraken/driver.html?testName=ai-astar) 16:15:57 INFO - PID 15543 | RSS: Main: 173961216 16:15:57 INFO - PID 15543 | 16:15:57 INFO - PID 15543 | __start_tp_report 16:15:57 INFO - PID 15543 | _x_x_mozilla_page_load 16:15:57 INFO - PID 15543 | _x_x_mozilla_page_load_details 16:15:57 INFO - PID 15543 | |i|pagename|runs| 16:15:57 INFO - PID 15543 | |0;ai-astar;97;109;102;107;107;109;109;100;107;112 16:15:57 INFO - PID 15543 | |1;audio-beat-detection;143;116;151;183;115;146;150;117;174;118 16:15:57 INFO - PID 15543 | |2;audio-dft;167;163;163;162;161;162;162;163;173;168 16:15:57 INFO - PID 15543 | |3;audio-fft;74;75;73;182;76;73;73;74;165;76 16:15:57 INFO - PID 15543 | |4;audio-oscillator;79;79;128;80;80;79;123;79;78;130 16:15:57 INFO - PID 15543 | |5;imaging-gaussian-blur;114;114;115;114;113;114;118;114;115;114 16:15:57 INFO - PID 15543 | |6;imaging-darkroom;151;147;148;147;150;147;149;148;149;148 16:15:57 INFO - PID 15543 | |7;imaging-desaturate;93;95;93;93;93;94;95;101;94;94 16:15:57 INFO - PID 15543 | |8;json-parse-financial;54;53;60;53;54;55;61;53;53;52 16:15:57 INFO - PID 15543 | |9;json-stringify-tinderbox;38;37;42;37;37;37;38;38;38;38 16:15:57 INFO - PID 15543 | |10;stanford-crypto-aes;75;76;76;75;75;75;74;75;77;76 16:15:57 INFO - PID 15543 | |11;stanford-crypto-ccm;124;123;117;116;120;123;123;128;119;155 16:15:57 INFO - PID 15543 | |12;stanford-crypto-pbkdf2;170;172;174;186;173;170;171;179;182;175 16:15:57 INFO - PID 15543 | |13;stanford-crypto-sha256-iterative;66;64;68;68;65;63;64;66;68;65 16:15:57 INFO - PID 15543 | __end_tp_report 16:15:57 INFO - PID 15543 | __start_cc_report 16:15:57 INFO - PID 15543 | _x_x_mozilla_cycle_collect,951 16:15:57 INFO - PID 15543 | __end_cc_report 16:15:57 INFO - PID 15543 | __startTimestamp1504394157817__endTimestamp 16:15:57 INFO - PID 15543 | 16:15:57 INFO - PID 15543 | ------- Summary: start ------- 16:15:57 INFO - PID 15543 | Number of tests: 14 16:15:57 INFO - PID 15543 | 16:15:57 INFO - PID 15543 | [#0] ai-astar Cycles:10 Average:105.90 Median:109.00 stddev:4.70 (4.3%) stddev-sans-first:3.72 16:15:57 INFO - PID 15543 | Values: 97.0 109.0 102.0 107.0 107.0 109.0 109.0 100.0 107.0 112.0 16:15:57 INFO - PID 15543 | 16:15:57 INFO - PID 15543 | [#1] audio-beat-detection Cycles:10 Average:141.30 Median:148.00 stddev:24.65 (16.7%) stddev-sans-first:26.14 16:15:57 INFO - PID 15543 | Values: 143.0 116.0 151.0 183.0 115.0 146.0 150.0 117.0 174.0 118.0 16:15:57 INFO - PID 15543 | 16:15:57 INFO - PID 15543 | [#2] audio-dft Cycles:10 Average:164.40 Median:163.00 stddev:3.78 (2.3%) stddev-sans-first:3.89 16:15:57 INFO - PID 15543 | Values: 167.0 163.0 163.0 162.0 161.0 162.0 162.0 163.0 173.0 168.0 16:15:57 INFO - PID 15543 | 16:15:57 INFO - PID 15543 | [#3] audio-fft Cycles:10 Average:94.10 Median:74.00 stddev:42.05 (56.8%) stddev-sans-first:43.97 16:15:57 INFO - PID 15543 | Values: 74.0 75.0 73.0 182.0 76.0 73.0 73.0 74.0 165.0 76.0 16:15:57 INFO - PID 15543 | 16:15:57 INFO - PID 15543 | [#4] audio-oscillator Cycles:10 Average:93.50 Median:79.00 stddev:23.19 (29.3%) stddev-sans-first:23.99 16:15:57 INFO - PID 15543 | Values: 79.0 79.0 128.0 80.0 80.0 79.0 123.0 79.0 78.0 130.0 16:15:57 INFO - PID 15543 | 16:15:57 INFO - PID 15543 | [#5] imaging-gaussian-blur Cycles:10 Average:114.50 Median:114.00 stddev:1.35 (1.2%) stddev-sans-first:1.42 16:15:57 INFO - PID 15543 | Values: 114.0 114.0 115.0 114.0 113.0 114.0 118.0 114.0 115.0 114.0 16:15:57 INFO - PID 15543 | 16:15:57 INFO - PID 15543 | [#6] imaging-darkroom Cycles:10 Average:148.40 Median:148.50 stddev:1.35 (0.9%) stddev-sans-first:1.05 16:15:57 INFO - PID 15543 | Values: 151.0 147.0 148.0 147.0 150.0 147.0 149.0 148.0 149.0 148.0 16:15:57 INFO - PID 15543 | 16:15:57 INFO - PID 15543 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:94.00 stddev:2.42 (2.6%) stddev-sans-first:2.50 16:15:57 INFO - PID 15543 | Values: 93.0 95.0 93.0 93.0 93.0 94.0 95.0 101.0 94.0 94.0 16:15:57 INFO - PID 15543 | 16:15:57 INFO - PID 15543 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:54.00 stddev:3.12 (5.8%) stddev-sans-first:3.30 16:15:57 INFO - PID 15543 | Values: 54.0 53.0 60.0 53.0 54.0 55.0 61.0 53.0 53.0 52.0 16:15:57 INFO - PID 15543 | 16:15:57 INFO - PID 15543 | [#9] json-stringify-tinderbox Cycles:10 Average:38.00 Median:38.00 stddev:1.49 (3.9%) stddev-sans-first:1.58 16:15:57 INFO - PID 15543 | Values: 38.0 37.0 42.0 37.0 37.0 37.0 38.0 38.0 38.0 38.0 16:15:57 INFO - PID 15543 | 16:15:57 INFO - PID 15543 | [#10] stanford-crypto-aes Cycles:10 Average:75.40 Median:75.50 stddev:0.84 (1.1%) stddev-sans-first:0.88 16:15:57 INFO - PID 15543 | Values: 75.0 76.0 76.0 75.0 75.0 75.0 74.0 75.0 77.0 76.0 16:15:57 INFO - PID 15543 | 16:15:57 INFO - PID 15543 | [#11] stanford-crypto-ccm Cycles:10 Average:124.80 Median:123.00 stddev:11.19 (9.1%) stddev-sans-first:11.87 16:15:57 INFO - PID 15543 | Values: 124.0 123.0 117.0 116.0 120.0 123.0 123.0 128.0 119.0 155.0 16:15:57 INFO - PID 15543 | 16:15:57 INFO - PID 15543 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.20 Median:174.50 stddev:5.43 (3.1%) stddev-sans-first:5.43 16:15:57 INFO - PID 15543 | Values: 170.0 172.0 174.0 186.0 173.0 170.0 171.0 179.0 182.0 175.0 16:15:57 INFO - PID 15543 | 16:15:57 INFO - PID 15543 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.70 Median:66.00 stddev:1.83 (2.8%) stddev-sans-first:1.94 16:15:57 INFO - PID 15543 | Values: 66.0 64.0 68.0 68.0 65.0 63.0 64.0 66.0 68.0 65.0 16:15:57 INFO - PID 15543 | -------- Summary: end -------- 16:15:57 INFO - PID 15543 | 16:15:58 INFO - PID 15543 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 16:15:58 INFO - TEST-INFO | 15543: exit 0 16:15:58 INFO - TEST-OK | kraken | took 60341ms 16:15:58 INFO - SUITE-END | took 1170s 16:15:58 INFO - Completed test suite (00:19:30) 16:15:58 INFO - javascript benchmark 16:15:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8662.337036680565, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3329.9833500832497, 3335.999200239929, 3344.046946620214, 3360.260742636619, 3373.207296285374, 6425.742970281183, 6451.870962580751, 6486.221653401592, 6497.545171837967, 6524.739010439576, 6357.809265722036, 6422.197225346832, 6441.838954026151, 6451.483881289498, 6462.579932304397, 5844.561657875655, 5865.912011319833, 5885.646861188332, 5890.440408161217, 5940.287165540141, 5904.350521442638, 5911.5270778337845, 5911.9113213301835, 5933.258342707161, 5970.1940238067955, 5884.617499862496, 5939.85150371242, 5990.970045149768, 5991.550633702468, 6072.969635151818, 5690.60165788395, 5909.23179986599, 5921.407859214087, 5936.0, 5997.280326360821, 5653.689047102408, 5772.682502462363, 5886.941130588682, 5918.674472903988, 5946.821595352147, 6353.462229769304, 6427.132337134521, 6433.9678301608665, 6450.451711604519, 6533.444657204143, 6734.528582999192, 6835.350641689031, 6869.7595584154815, 6903.447724182053, 7012.859742805166, 6963.40811031063, 6981.79054628362, 6984.266652001568, 6985.965070174668, 6986.930130698679, 6458.838529036765, 6520.250171230275, 6542.084108224853, 6554.9839774835455, 6557.737690492327, 7116.217216106224, 7136.6431678415875, 7143.357097861218, 7251.057362542836, 7252.057232559733, 6601.108850305147, 6674.098996635489, 6743.123393958852, 6859.416949559243, 6907.171139463196, 6841.93158068413, 6926.688299026556, 6944.861102777916, 6945.0971373721095, 6992.650367481708, 6895.379415852597, 6920.723171073201, 6951.339622735832, 6951.965240173767, 6961.721531138698, 6925.480588955848, 6930.27232140618, 6997.230304666483, 7010.684519196649, 7024.719011239596, 5346.973265133727, 5392.91910621341, 5394.541463975606, 5431.864203394946, 5448.128299472145, 4762.452317983476, 4807.831725889577, 4823.27650852375, 4832.251001094836, 4843.878903027453, 5909.6158749681135, 5963.850903727354, 6071.119687645267, 6072.36240194782, 6147.0779383092895, 6971.093757811452, 7053.259407762213, 7055.470839687044, 7083.787486375417, 7085.32689394517, 6044.486218671374, 6055.303640081359, 6108.053251745898, 6129.203203583595, 6139.969300153471, 5861.677607731531, 5886.293644762571, 5931.673757943355, 5971.28344598651, 6010.759569617167, 6739.157605299338, 6750.3924646782025, 6756.966215168893, 6757.020232066421, 6760.357766012221, 6877.346652068046, 6999.440044796303, 7060.435165186876, 7061.152661680631, 7063.858722825617, 6728.73085076611, 6735.898961515679, 6801.149856267966, 6802.6258555779905, 6817.829554260985, 6605.834854128493, 6681.76613818514, 6796.320367963164, 6831.658417079226, 6926.826829329307, 7009.7897063088185, 7018.894716579358, 7037.472189585904, 7046.0, 7046.295370462913, 6755.560888542229, 6822.965885170543, 6827.2490026098085, 6827.48793840454, 6834.179898412222, 6719.966400168163, 6742.6628668567355, 6828.624425656637, 6832.726690932307, 6841.623710695761, 6545.541812073109, 6612.966935165294, 6615.801525954229, 6631.104800851823, 6720.899186512304, 6785.830354241183, 6795.660216989229, 6826.385625293748, 6843.315668433316, 6867.519273650796, 6545.050967609765, 6561.967190164019, 6627.536072474881, 6650.3682150195655, 6659.600423974577], "value": 6328.218528649402, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [782.4640121516761, 833.3041910005145, 863.1799790199312, 1111.699841042919, 1128.808102622554, 30203.848980755094, 39463.210735785266, 41207.58792412075, 41244.0, 41377.37933930993, 41064.79467602665, 41222.79388603053, 41320.38019429711, 41423.58576414235, 41477.79261103698, 7571.734989275376, 7731.497452665587, 7735.845283094335, 7744.496607720508, 7749.147593764681, 7554.791233402657, 7689.7693069207735, 7698.499597526171, 7705.499142555744, 7710.383169346439, 7125.928740712604, 7355.595442250701, 7761.0, 7763.961180194091, 7764.3788496920115, 7665.808354791119, 7710.884336734954, 7726.266004729542, 7727.072751269883, 7727.227277272256, 7600.619969001527, 7672.232776722283, 7686.615669216572, 7687.461877668566, 7700.422468314843, 36264.63735362639, 36515.817420912725, 36541.45187822185, 36629.450558241646, 36644.81677591595, 3509.7543171977973, 3542.220711443478, 3555.928881422357, 3560.2523470071055, 3560.964390356115, 30501.0, 30564.694353056406, 30665.080047598607, 30666.62000209996, 30667.69332306693, 4831.830885918976, 4925.9409227016, 5011.749412529359, 5031.899362012739, 5115.744212789383, 193068.0, 195518.0, 196156.0, 197796.0, 198553.0, 47381.763091185014, 47668.0, 47706.0, 47737.522624774, 47829.0, 50291.245631315556, 50529.0, 50635.49364506381, 50667.23999140016, 50667.493325067015, 15610.45363412275, 15847.366105355888, 15872.52382428529, 15893.682126357407, 15911.204439777965, 13036.869631303754, 13049.934750326378, 13081.672958175932, 13098.345082745825, 13115.737685246433, 12596.307203103917, 13806.792898106536, 14026.298685065705, 14031.859681403055, 14253.78619320711, 4923.6952207665, 5732.254806875079, 5748.425157484218, 5767.36558978512, 6016.067509536029, 976.2043934193752, 1005.2912696548915, 1007.219404961161, 1015.3095894791466, 1016.2124353625999, 23089.53820923572, 27974.86012569924, 28338.858305708753, 29119.41761164765, 29303.706962930522, 1085.8642669666292, 1088.6516314779194, 1093.185576745314, 1095.1567293184362, 1098.8132017557034, 11816.46825892837, 12102.273863568214, 12152.57465988704, 12179.330136842558, 12197.573084942162, 248130.0, 250015.0, 250015.0, 251302.0, 252019.0, 51420.22869656958, 51725.0, 51733.22400164, 51822.0, 51858.48141518612, 1379.5861241627472, 1432.6776475293184, 1450.579331993731, 1451.6153219396867, 1465.7068586282787, 21751.0, 21942.0, 22423.0, 22457.887710561998, 22480.66279005849, 48134.0, 49027.509724902295, 49456.50543494519, 49495.0, 49614.50385496099, 210076.0, 211468.0, 211708.0, 211991.0, 220394.0, 36029.0, 36173.638263617024, 36474.0, 36561.0, 36667.26665466622, 41869.1626167481, 44994.550054500345, 45213.773931130134, 45309.546904530536, 45457.77271113623, 33333.0, 33521.66478335185, 33734.83132584322, 33755.32489350248, 33912.83043584865, 32837.17907052343, 32921.83539082289, 33130.834345828116, 33508.1622959428, 33539.83230083834, 37102.25795484129, 37406.438903415925, 37528.81235593805, 37766.0, 37974.0, 32290.677093228765, 32511.0, 32661.836690816395, 32953.83523082369, 33137.83431082829, 23375.0, 24206.15278465245, 24571.8771406149, 25052.0, 25351.36621584475], "value": 17459.243162504856, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [554.2268535393126, 561.8370672504974, 571.7284289962271, 584.1558947321122, 585.8037557418266, 22272.109115635376, 22931.0, 22954.770452295474, 23013.0, 23555.528889422243, 24523.75476245237, 25287.87356063222, 25322.87338563309, 25401.61897571538, 25414.872925635347, 6294.244690637107, 6509.674516274179, 6651.301613330603, 6655.567388119781, 6655.767048153316, 6437.613743175424, 6528.151340325775, 6529.608223506581, 6533.05270735743, 6535.444487218592, 6475.190601174853, 6478.319776423478, 6482.416582507573, 6489.772857949973, 6489.967550162242, 6468.3208263132165, 6490.058941453486, 6510.023496475519, 6510.218773747133, 6515.674216289167, 6004.939950600526, 6012.128241405016, 6018.067199584071, 6018.127371531104, 6033.698315084228, 28015.159545213675, 28557.57163642547, 29518.671659775147, 29738.0, 29814.55278170829, 2050.5796311756053, 2071.8446116541318, 2071.989640051805, 2076.3355726167633, 2084.749830020392, 19060.61878762431, 19722.80277197224, 19745.802541974685, 19750.506237344038, 19764.50588735279, 2282.3609389371004, 2314.1437668062927, 2341.6019276722827, 2350.424146084203, 2398.040783686522, 130984.0, 135855.0, 139318.0, 139529.0, 139530.0, 13726.65683357904, 14704.26478676062, 14764.187969661556, 14999.250037498081, 15375.61560960985, 22955.196568120034, 23018.194363197206, 23036.4240893979, 23041.42396440069, 23063.42341441444, 10166.390016599027, 10286.074253317087, 10299.691009269734, 10387.68836934893, 10451.634192803216, 8451.1548845115, 8792.47245165292, 9006.729798106067, 9369.672061477815, 9685.515724213761, 8944.955275223712, 9146.81706365869, 9215.953920230357, 9252.7686807829, 9279.443233406017, 2674.7191544887505, 2702.9864850676013, 2713.8914443422436, 2733.72662733725, 2767.972320276812, 959.8944116147218, 976.5605477535138, 981.249344251648, 988.4415305352453, 993.6671215143008, 19397.709034364496, 19533.0, 19618.509537261398, 20042.298519551747, 23432.64851027236, 1018.4347687033768, 1054.1830081686753, 1059.655611926127, 1059.782744537368, 1061.792950374685, 10721.35671859691, 11435.656930291938, 13050.673733156556, 13456.25990570528, 13706.725865482835, 519990.0, 541205.4698632486, 545056.0, 562940.0, 564016.0, 117514.0, 117532.0, 120343.0, 121879.0, 122766.0, 1212.345333519907, 1230.833837431953, 1241.6647505173732, 1257.4592925042136, 1258.3393718297784, 20931.16275348969, 21068.47328816792, 21294.78705212928, 21362.679559806926, 21473.67789483128, 59510.0, 60768.39231607627, 61647.691761540904, 61739.69130154321, 63105.68447157735, 72976.27023729908, 73107.0, 73552.0, 73562.0, 73787.63106184435, 11863.466144023367, 12193.0, 13970.650733731738, 14589.27053647292, 14870.776938345716, 22604.321870343916, 22689.205877794197, 22754.886225568767, 22784.31647050591, 23252.3024309271, 18148.274069037092, 18578.535536611693, 18608.16263268129, 18761.624767504847, 18764.530886727942, 16380.262888169822, 16388.83611163873, 16522.83477165261, 16821.0, 16882.24029918681, 18592.25630974746, 18632.254709811456, 18653.347132850286, 18785.0, 18805.529861753017, 14206.07660502064, 14322.928385358007, 14339.354729037426, 14498.202598856742, 14536.636584085483, 18058.909705451388, 18251.634967300844, 18280.45158645243, 18325.633487329913, 18442.35451759182], "value": 12122.36207181942, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1286.8327117474728, 1321.2072756346192, 1337.5051231044504, 1344.959651210464, 1353.377446374667, 14677.0, 15290.31193596288, 15397.384104635801, 15409.383624655, 15421.0, 15382.769258461103, 15889.761653575206, 15924.76112858308, 15932.522024339289, 15935.681286374265, 2786.5262905306095, 2834.829910205384, 2834.9716502834913, 2835.3903910659205, 2836.0, 2833.3766571354267, 2946.646402431711, 2949.4985852405034, 2951.0, 2951.483490389184, 2768.4463107378506, 2825.22306365749, 2833.4333133373307, 2842.6020357149914, 2873.224229458045, 2788.177487641151, 2808.354078561932, 2819.2669905824428, 2821.3087793490727, 2825.9576106358422, 2697.1908427471876, 2739.369944912661, 2757.214193954733, 2773.195773225762, 2779.2496026072845, 14816.555503334917, 15155.62110947224, 15162.696746065018, 15192.468263610832, 15249.61875953099, 8213.712520061828, 8444.746657600283, 8470.407071504997, 8472.025717042558, 8493.575321233913, 5344.812931547377, 5453.536449401806, 5528.612997090206, 5606.271184745998, 5631.690257035862, 1928.4985903665008, 1932.5265309999, 1936.9612607747906, 1957.3853731357947, 1998.69020301852, 26492.337691557674, 26851.86574067117, 26900.0, 26925.32686682829, 26927.32681682954, 7033.8241543960785, 7310.268973102648, 7456.40348772097, 7656.119546252141, 7714.228577142241, 16359.67280654404, 16418.507444776675, 16430.507084787238, 16475.176241188132, 16477.176141192893, 7899.0126234220725, 8015.118336983044, 8047.396445266511, 8056.315213206943, 8078.151794061657, 7361.852762944711, 7416.369608583331, 7482.588457634883, 7520.736774212985, 7532.849343013109, 5239.921401178985, 5356.464353564613, 5431.076716958127, 5450.4549545045975, 5477.863053423696, 1579.2498563182396, 1589.308650736933, 1589.4436947068434, 1617.9029258244543, 1618.919054047293, 886.8137691084816, 915.7802127489355, 921.8294615496154, 933.8179055084329, 934.238595544629, 7836.764897053097, 7932.524048557105, 7966.920330796734, 7974.401919856034, 8028.397870159644, 726.5287792220689, 728.8651599454118, 738.0921466596117, 742.7474658616096, 751.6880494594791, 4914.533119353656, 5167.250748641426, 5268.025415298182, 5338.786448542092, 5755.7122143893475, 21379.0, 21505.462363441038, 22003.669944950838, 22364.99357528915, 22400.775992240197, 21590.352289431343, 21958.670619940713, 22251.221207257993, 22371.32886013422, 22377.776222237568, 11217.439128043728, 11488.597899073493, 11596.594119205956, 11612.12909031809, 11656.592019279284, 8549.572521373782, 8692.39153259291, 8735.039145693841, 8785.824283514166, 8816.382853200472, 18488.16803243884, 18572.44282671522, 18787.436376908714, 18844.152013159714, 18889.527761806065, 19317.903410482857, 19347.0, 19347.129379177688, 19403.320883769, 19539.120739566468, 11011.724706882393, 11077.11383089367, 11179.60871369498, 11182.832257515982, 11184.105271578092, 13854.861451385357, 14036.228007459687, 14041.017128800886, 14059.578212653636, 14062.78905816434, 11258.718532036764, 11308.43457827089, 11343.20597558163, 11375.772484550098, 11622.6513204604, 11053.392063436266, 11129.833052504056, 11173.55305787792, 11398.886011139783, 11494.94252528732, 9707.805843883225, 9960.701178964642, 9963.651272205729, 9997.900020999989, 10068.69793906184, 7472.589007604634, 7673.654685539276, 7842.725504607311, 7858.764237072897, 7882.330001949669, 7188.0, 7241.855162896818, 7301.926980730337, 7342.9632851835395, 7358.300961408658], "value": 6760.4508046307765, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [509.3378607809846, 515.2503107977891, 528.1813189556188, 535.5126834580533, 538.3943064052941, 6305.148804911341, 6383.234011918565, 6407.647579383132, 6408.295087540373, 6418.518611104162, 6213.813585592439, 6222.160008398865, 6251.2498500180045, 6272.905906411407, 6297.275813281474, 5113.079645663779, 5163.586913046947, 5170.405403378603, 5173.689578625294, 5196.740162991854, 4834.444038935515, 5117.820876269331, 5217.34783152106, 5230.398504172012, 5236.738163091849, 4913.778879950393, 4940.777665005084, 4964.900701985976, 4977.900441991158, 4979.975100124494, 4918.401519506175, 4986.725730084844, 5002.9493806300725, 5022.874428139289, 5040.571551418134, 4344.174606824725, 4458.308962110878, 4483.50681425043, 4486.4616246050355, 4514.164879497303, 6033.0, 6105.481034112106, 6116.663583502906, 6131.448169664707, 6163.537734669918, 5691.573132015115, 5694.544436445074, 5714.885702285973, 5715.685637289947, 5727.9427205727825, 6444.420002199778, 6601.63690996995, 6643.534952553275, 6660.2340730816095, 6711.832204194934, 4884.29177769225, 4896.510348965111, 4913.950860491385, 4928.359313289286, 4946.455889852114, 6603.867922641521, 6617.239017512999, 6682.899756503656, 6952.374286314205, 6996.930030699678, 4954.752262386866, 4974.403071631355, 4999.350084488993, 5003.5997120230295, 5043.344365232496, 5028.823991160292, 5068.366454193226, 5073.441921388644, 5087.974560127176, 5122.257272695513, 5639.295088113986, 5664.49019588239, 5688.317401911797, 5693.857653558612, 5732.226149469851, 6651.600903945779, 6672.899906501407, 6691.130153080068, 6700.262971073178, 6779.186497620317, 1766.938157164493, 1771.5128339706425, 1774.4587900690412, 1779.4429873860372, 1785.7589225454396, 1160.5995931403652, 1210.2556927489532, 1219.951201951912, 1220.7924652809045, 1226.1907141286708, 5836.533077353886, 5891.440313170242, 5917.201177841022, 5934.495567876693, 5999.700014999233, 6720.529562930548, 6742.0, 6770.8645827084165, 6819.283975182534, 6821.829454263683, 5881.264841894763, 5881.41185881417, 5904.852378690567, 5935.436133567304, 5978.940210597925, 3565.286942611436, 3569.5894972078545, 3619.0, 3620.8913732588067, 3626.2384899170943, 6568.573042752206, 6587.703553340111, 6592.538522303393, 6615.206175258903, 6619.900701489481, 6991.7902462926195, 7002.159740831133, 7026.824329391806, 7038.859222815515, 7111.359977602041, 6114.877702445926, 6499.155109835691, 6539.084528165966, 6607.702653380609, 6611.867762644816, 6680.432163266177, 6773.458123350219, 6778.42383397397, 6796.93203067963, 6798.796036118924, 6375.936240637534, 6650.434713049445, 6690.498212634169, 6695.296993815579, 6709.705788295397, 6399.168108145911, 6500.934990650222, 6517.73929042833, 6536.8365790855605, 6590.209174899042, 5002.974985125051, 5089.694618322913, 5102.744862756773, 5102.974485127551, 5118.74406279692, 6532.771353002812, 6622.933770662232, 6707.960266158753, 6948.270431604811, 6952.860942781217, 6522.380373864476, 6533.18335208099, 6551.181102362205, 6575.408213260829, 6611.710716410254, 6469.8706025880165, 6532.05285233648, 6532.673366331759, 6595.17399491524, 6658.300878407697, 6469.417752402306, 6532.673366331759, 6556.18047744032, 6571.96714016446, 6580.276169621242, 6651.838152600328, 6676.0, 6683.398494135551, 6732.562383445061, 6776.86446271062, 6344.9048264277, 6419.977707022273, 6446.5165112615805, 6447.70985305653, 6515.250746164252], "value": 5103.31312857775, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [905.275779376499, 910.4309806371017, 929.1637526226391, 929.4098247612768, 934.1825902335456, 17603.647927041453, 18742.53143671409, 18787.906060469697, 18815.247390104378, 18902.432927012178, 16865.07242101684, 18192.818071819278, 20694.379168624928, 20705.482362940933, 20861.582768344622, 986.1666891476708, 997.7954519323521, 997.8154041502308, 1002.6290272599113, 1004.0812656419404, 948.393028461785, 995.3480470291934, 1003.7992401519689, 1005.7737009172951, 1005.8239808033602, 1050.7163065972184, 1051.8842927277992, 1053.0943388685723, 1053.346924906559, 1054.2514814481726, 1050.1074087026043, 1050.3120456101267, 1052.0478966535297, 1052.952617132227, 1059.729768908927, 773.8645736996003, 773.9187385324516, 774.349546381037, 775.767269819052, 781.3436713160972, 16896.408625698165, 17309.91345043267, 17501.56246093845, 17791.288348466045, 17936.0, 19864.80135198644, 20359.0, 20686.379408617617, 20768.896155519127, 20797.376078717512, 16255.431059912846, 16957.830421695748, 17020.319187232497, 17033.7444938326, 17093.572660683458, 3717.20080182762, 3745.8501659933568, 3747.306748251555, 3747.7376583639157, 3752.3058234226755, 124481.0, 125906.99999999908, 128070.0, 131372.0, 132499.0, 16829.83170168307, 17431.47705568835, 17551.64896702059, 17626.29494820193, 17628.20673069715, 29938.0, 31079.84460077685, 31427.685723142935, 31566.36867262642, 31590.842045790083, 8877.422967507091, 8916.955415223012, 8919.375643705009, 8951.507667078373, 8967.237784788365, 3893.7079719021185, 4192.098698779716, 4244.214820258262, 4255.340422234559, 4262.744235345889, 5266.131088370376, 5399.83800485986, 5400.540954018874, 5426.511613954763, 5439.809606663827, 1105.6406667832987, 1127.6109742139113, 1144.376314908377, 1147.3345459633392, 1158.2818652435376, 694.6318451220861, 712.2556928010242, 718.8418547919449, 719.8416348403343, 738.2027410396759, 10871.508993821, 12110.75778484443, 13134.60596182116, 13286.867131328756, 13621.318934053257, 702.2310569925922, 709.4218212157075, 718.0593422616389, 725.9528130671489, 740.3484933258698, 5898.439648233411, 6120.14317995481, 6194.907076393858, 6228.408301211378, 6238.532110091761, 104321.0, 105598.0, 109594.62497190226, 110533.0, 110662.0, 94975.0, 96075.0, 96850.0, 99743.0, 99951.50024249832, 87654.0, 88225.0, 88936.11063889408, 90130.54934725416, 90982.54508727413, 12401.0, 12642.55751048709, 12756.653138244485, 12784.232946023269, 12794.872051279368, 39532.2093558133, 41147.58852411557, 41611.0, 41726.37410438906, 42138.36792448177, 50892.98214035772, 53015.0, 53028.204576930606, 54505.72747136239, 54928.450715492334, 17236.655266894842, 17413.564660883072, 17419.129043548026, 17583.560410989317, 17595.64808703793, 20776.58446831085, 20780.1687932481, 20858.0, 20908.05913733855, 21010.68483972711, 17813.46559603214, 18009.369672061413, 18038.0, 18080.367187148386, 18196.27214911442, 17976.82023179804, 18118.5470363242, 18277.177527011052, 18297.0, 18419.07904604791, 16156.11141387235, 16262.186890655183, 16336.183190840648, 16422.917885410498, 16813.41153059637, 12486.188397754117, 13370.997175211704, 13496.932515337361, 13714.794278085637, 13794.517191898236, 13667.453301867814, 14177.078489898124, 14189.0, 14248.857511424752, 14294.857051429353], "value": 9142.460794479579, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1490.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 109.0, 102.0, 107.0, 107.0, 109.0, 109.0, 100.0, 107.0, 112.0], "value": 105.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 116.0, 151.0, 183.0, 115.0, 146.0, 150.0, 117.0, 174.0, 118.0], "value": 141.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 163.0, 163.0, 162.0, 161.0, 162.0, 162.0, 163.0, 173.0, 168.0], "value": 164.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 73.0, 182.0, 76.0, 73.0, 73.0, 74.0, 165.0, 76.0], "value": 94.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 128.0, 80.0, 80.0, 79.0, 123.0, 79.0, 78.0, 130.0], "value": 93.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 115.0, 114.0, 113.0, 114.0, 118.0, 114.0, 115.0, 114.0], "value": 114.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 147.0, 148.0, 147.0, 150.0, 147.0, 149.0, 148.0, 149.0, 148.0], "value": 148.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 95.0, 93.0, 93.0, 93.0, 94.0, 95.0, 101.0, 94.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 60.0, 53.0, 54.0, 55.0, 61.0, 53.0, 53.0, 52.0], "value": 54.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 37.0, 42.0, 37.0, 37.0, 37.0, 38.0, 38.0, 38.0, 38.0], "value": 38.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 75.0, 75.0, 75.0, 74.0, 75.0, 77.0, 76.0], "value": 75.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 123.0, 117.0, 116.0, 120.0, 123.0, 123.0, 128.0, 119.0, 155.0], "value": 124.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 172.0, 174.0, 186.0, 173.0, 170.0, 171.0, 179.0, 182.0, 175.0], "value": 175.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 68.0, 68.0, 65.0, 63.0, 64.0, 66.0, 68.0, 65.0], "value": 65.7, "unit": "score"}]}]} 16:15:59 INFO - Return code: 0 16:15:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:15:59 INFO - # TBPL SUCCESS # 16:15:59 INFO - Running post-action listener: _package_coverage_data 16:15:59 INFO - Running post-action listener: _resource_record_post_action 16:15:59 INFO - [mozharness: 2017-09-02 23:15:59.104452Z] Finished run-tests step (success) 16:15:59 INFO - Running post-run listener: _resource_record_post_run 16:15:59 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 147456; Write bytes: 392376320; Read time: 44; Write time: 228940 16:15:59 INFO - TinderboxPrint: CPU usage
13.1% 16:15:59 INFO - TinderboxPrint: I/O read bytes / time
147,456 / 44 16:15:59 INFO - TinderboxPrint: I/O write bytes / time
392,376,320 / 228,940 16:15:59 INFO - TinderboxPrint: CPU idle
8,230.6 (86.9%) 16:15:59 INFO - TinderboxPrint: CPU user
1,191.6 (12.6%) 16:15:59 INFO - TinderboxPrint: Swap in / out
0 / 0 16:15:59 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 106430464; Read time: 0; Write time: 73376 16:15:59 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 16:15:59 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 147456; Write bytes: 285945856; Read time: 44; Write time: 155564 16:15:59 INFO - Running post-run listener: _upload_blobber_files 16:15:59 INFO - Blob upload gear active. 16:15:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:15:59 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:15:59 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:15:59 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:16:00 INFO - (blobuploader) - INFO - Open directory for files ... 16:16:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:16:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:16:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:16:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:16:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:16:07 INFO - (blobuploader) - INFO - Done attempting. 16:16:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:16:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:16:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:16:08 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:16:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:16:08 INFO - (blobuploader) - INFO - Done attempting. 16:16:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:16:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:16:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:16:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:16:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:16:09 INFO - (blobuploader) - INFO - Done attempting. 16:16:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:16:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:16:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:16:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:16:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:16:10 INFO - (blobuploader) - INFO - Done attempting. 16:16:10 INFO - (blobuploader) - INFO - Iteration through files over. 16:16:10 INFO - Return code: 0 16:16:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:16:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:16:10 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/99f2e0abc30e4c0563400e35c5649302168a9d29a24b8ae1de71db35cd77a54da14f158967da90c61589c2795223e8e5fcef98660218e88fa1d5d05448d44c2b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d9d872d742178bd9e3a7722711e7b99104af50515fde87b2b7c4b3353c0ef683376485fe29690bae3e55e428278ebf5ae2b183f91fe89ac7f96c8dc61e276018", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ef493c174be15e2900bcb3b5c0395ab06db732465f90afc6506df8df90eca37df58a9a99addedaa197a035c87bbdf9fc489f8533910def95702f097650284a88", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/696d6a4bcc2bdce358c365b89cd133556af0cca74e9f0dd0c14a8cb73cd7851144b7704682e4bb7bb02f153b738e373481b9f97ad9ae3b9b78b89f3b9ed66f0d"} 16:16:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:16:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:16:10 INFO - Contents: 16:16:10 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/99f2e0abc30e4c0563400e35c5649302168a9d29a24b8ae1de71db35cd77a54da14f158967da90c61589c2795223e8e5fcef98660218e88fa1d5d05448d44c2b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d9d872d742178bd9e3a7722711e7b99104af50515fde87b2b7c4b3353c0ef683376485fe29690bae3e55e428278ebf5ae2b183f91fe89ac7f96c8dc61e276018", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ef493c174be15e2900bcb3b5c0395ab06db732465f90afc6506df8df90eca37df58a9a99addedaa197a035c87bbdf9fc489f8533910def95702f097650284a88", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/696d6a4bcc2bdce358c365b89cd133556af0cca74e9f0dd0c14a8cb73cd7851144b7704682e4bb7bb02f153b738e373481b9f97ad9ae3b9b78b89f3b9ed66f0d"} 16:16:10 INFO - Running post-run listener: copy_logs_to_upload_dir 16:16:10 INFO - Copying logs to upload dir... 16:16:10 INFO - mkdir: /builds/slave/test/build/upload/logs 16:16:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.447570 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-09-02 16:16:10.143402) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-02 16:16:10.147146) ========= 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=31acecf42b6a79ec49471d4a000001bb-1504392919.881673-574566209 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/99f2e0abc30e4c0563400e35c5649302168a9d29a24b8ae1de71db35cd77a54da14f158967da90c61589c2795223e8e5fcef98660218e88fa1d5d05448d44c2b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d9d872d742178bd9e3a7722711e7b99104af50515fde87b2b7c4b3353c0ef683376485fe29690bae3e55e428278ebf5ae2b183f91fe89ac7f96c8dc61e276018", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ef493c174be15e2900bcb3b5c0395ab06db732465f90afc6506df8df90eca37df58a9a99addedaa197a035c87bbdf9fc489f8533910def95702f097650284a88", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/696d6a4bcc2bdce358c365b89cd133556af0cca74e9f0dd0c14a8cb73cd7851144b7704682e4bb7bb02f153b738e373481b9f97ad9ae3b9b78b89f3b9ed66f0d"} build_url:https://queue.taskcluster.net/v1/task/EForbR1USZeEN3w5edfxHw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011481 build_url: 'https://queue.taskcluster.net/v1/task/EForbR1USZeEN3w5edfxHw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/99f2e0abc30e4c0563400e35c5649302168a9d29a24b8ae1de71db35cd77a54da14f158967da90c61589c2795223e8e5fcef98660218e88fa1d5d05448d44c2b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d9d872d742178bd9e3a7722711e7b99104af50515fde87b2b7c4b3353c0ef683376485fe29690bae3e55e428278ebf5ae2b183f91fe89ac7f96c8dc61e276018", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ef493c174be15e2900bcb3b5c0395ab06db732465f90afc6506df8df90eca37df58a9a99addedaa197a035c87bbdf9fc489f8533910def95702f097650284a88", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/696d6a4bcc2bdce358c365b89cd133556af0cca74e9f0dd0c14a8cb73cd7851144b7704682e4bb7bb02f153b738e373481b9f97ad9ae3b9b78b89f3b9ed66f0d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-02 16:16:10.175690) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-02 16:16:10.176042) ========= 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=31acecf42b6a79ec49471d4a000001bb-1504392919.881673-574566209 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004532 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-02 16:16:10.261787) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-02 16:16:10.262162) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-02 16:16:10.262462) ========= ========= Total master_lag: 0.20 =========