builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s-pgo slave: talos-linux64-ix-058 starttime: 1504788184.96 results: success (0) revision: 6469a2cb7df662afb23493b5566f99b6802fcb5a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-07 05:43:04.955832) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-07 05:43:04.956269) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-07 05:43:04.956573) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-07 05:43:04.974509) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 05:43:04.974989) ========= 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=0e2a256762fed810e2f0f810000001b3-1504788184.137758-2072291508 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-07 05:43:04-- 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% 45.9M=0s 2017-09-07 05:43:05 (45.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.123508 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 05:43:05.117392) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 05:43:05.117933) ========= 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=0e2a256762fed810e2f0f810000001b3-1504788184.137758-2072291508 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021456 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 05:43:05.168563) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 05:43:05.168898) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6469a2cb7df662afb23493b5566f99b6802fcb5a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 6469a2cb7df662afb23493b5566f99b6802fcb5a --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0e2a256762fed810e2f0f810000001b3-1504788184.137758-2072291508 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-07 05:43:05,223 truncating revision to first 12 chars 2017-09-07 05:43:05,223 Setting DEBUG logging. 2017-09-07 05:43:05,223 attempt 1/10 2017-09-07 05:43:05,223 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6469a2cb7df6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-07 05:43:05,625 unpacking tar archive at: mozilla-central-6469a2cb7df6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.671756 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 05:43:05.857339) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-07 05:43:05.857661) ========= script_repo_revision: 6469a2cb7df662afb23493b5566f99b6802fcb5a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-07 05:43:05.858018) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-07 05:43:05.858278) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-07 05:43:05.871802) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2017-09-07 05:43:05.872184) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-stylo-disabled-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0e2a256762fed810e2f0f810000001b3-1504788184.137758-2072291508 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:43:06 INFO - MultiFileLogger online at 20170907 05:43:06 in /builds/slave/test 05:43:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:43:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:43:06 INFO - {'append_to_log': False, 05:43:06 INFO - 'base_work_dir': '/builds/slave/test', 05:43:06 INFO - 'blob_upload_branch': 'Firefox', 05:43:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:43:06 INFO - 'branch': 'Firefox', 05:43:06 INFO - 'buildbot_json_path': 'buildprops.json', 05:43:06 INFO - 'code_coverage': False, 05:43:06 INFO - 'config_files': ('talos/linux_config.py',), 05:43:06 INFO - 'default_actions': ('clobber', 05:43:06 INFO - 'read-buildbot-config', 05:43:06 INFO - 'download-and-extract', 05:43:06 INFO - 'populate-webroot', 05:43:06 INFO - 'create-virtualenv', 05:43:06 INFO - 'install', 05:43:06 INFO - 'setup-mitmproxy', 05:43:06 INFO - 'run-tests'), 05:43:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:43:06 INFO - 'disable_ccov_upload': False, 05:43:06 INFO - 'disable_stylo': False, 05:43:06 INFO - 'download_minidump_stackwalk': True, 05:43:06 INFO - 'download_symbols': 'ondemand', 05:43:06 INFO - 'enable_stylo': False, 05:43:06 INFO - 'enable_webrender': False, 05:43:06 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 05:43:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:43:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:43:06 INFO - 'gecko_profile': False, 05:43:06 INFO - 'gecko_profile_interval': 0, 05:43:06 INFO - 'installer_path': 'installer.exe', 05:43:06 INFO - 'log_level': 'info', 05:43:06 INFO - 'log_name': 'talos', 05:43:06 INFO - 'log_to_console': True, 05:43:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:43:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:43:06 INFO - 'opt_config_files': (), 05:43:06 INFO - 'pip_index': False, 05:43:06 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 05:43:06 INFO - 'system_bits': '32', 05:43:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:43:06 INFO - 'title': 'talos-linux64-ix-058', 05:43:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:43:06 INFO - 'use_talos_json': True, 05:43:06 INFO - 'verify': 'False', 05:43:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:43:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:43:06 INFO - 'work_dir': 'build'} 05:43:06 INFO - [mozharness: 2017-09-07 12:43:06.063079Z] Running clobber step. 05:43:06 INFO - Running pre-action listener: _resource_record_pre_action 05:43:06 INFO - Running main action method: clobber 05:43:06 INFO - rmtree: /builds/slave/test/build 05:43:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:43:07 INFO - Running post-action listener: _resource_record_post_action 05:43:07 INFO - [mozharness: 2017-09-07 12:43:07.070499Z] Finished clobber step (success) 05:43:07 INFO - [mozharness: 2017-09-07 12:43:07.070597Z] Running read-buildbot-config step. 05:43:07 INFO - Running pre-action listener: _resource_record_pre_action 05:43:07 INFO - Running main action method: read_buildbot_config 05:43:07 INFO - Using buildbot properties: 05:43:07 INFO - { 05:43:07 INFO - "project": "", 05:43:07 INFO - "product": "firefox", 05:43:07 INFO - "who": "archaeopteryx@coole-files.de", 05:43:07 INFO - "installer_path": "public/build/target.tar.bz2", 05:43:07 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 05:43:07 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 05:43:07 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-stylo-disabled-e10s", 05:43:07 INFO - "stage_platform": "linux64-pgo", 05:43:07 INFO - "basedir": "/builds/slave/test", 05:43:07 INFO - "buildnumber": 2, 05:43:07 INFO - "platform": "ubuntu64_hw", 05:43:07 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:43:07 INFO - "slavebuilddir": "test", 05:43:07 INFO - "taskId": "YQ6sc_Z6RvSuzPqmOA2l6A", 05:43:07 INFO - "branch": "mozilla-central", 05:43:07 INFO - "script_repo_revision": "production", 05:43:07 INFO - "revision": "6469a2cb7df662afb23493b5566f99b6802fcb5a", 05:43:07 INFO - "slavename": "talos-linux64-ix-058", 05:43:07 INFO - "repo_path": "mozilla-central" 05:43:07 INFO - } 05:43:07 INFO - Finding installer, test and symbols from parent task. 05:43:07 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YQ6sc_Z6RvSuzPqmOA2l6A'}, attempt #1 05:43:07 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YQ6sc_Z6RvSuzPqmOA2l6A'}, attempt #1 05:43:07 INFO - Task dependencies: THhrxJvGRaSBpbmI92T5WQ 05:43:07 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/THhrxJvGRaSBpbmI92T5WQ'}, attempt #1 05:43:08 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/THhrxJvGRaSBpbmI92T5WQ/artifacts/public/build/target.tar.bz2 05:43:08 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/THhrxJvGRaSBpbmI92T5WQ/artifacts/public/build/target.test_packages.json 05:43:08 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/THhrxJvGRaSBpbmI92T5WQ/artifacts/public/build/target.crashreporter-symbols.zip 05:43:08 INFO - Running post-action listener: _resource_record_post_action 05:43:08 INFO - [mozharness: 2017-09-07 12:43:08.439412Z] Finished read-buildbot-config step (success) 05:43:08 INFO - [mozharness: 2017-09-07 12:43:08.439633Z] Running download-and-extract step. 05:43:08 INFO - Running pre-action listener: _resource_record_pre_action 05:43:08 INFO - Running main action method: download_and_extract 05:43:08 INFO - mkdir: /builds/slave/test/build/tests 05:43: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')]} 05:43:08 INFO - trying https://queue.taskcluster.net/v1/task/THhrxJvGRaSBpbmI92T5WQ/artifacts/public/build/target.test_packages.json 05:43:08 INFO - Downloading https://queue.taskcluster.net/v1/task/THhrxJvGRaSBpbmI92T5WQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 05:43:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/THhrxJvGRaSBpbmI92T5WQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 05:43:08 INFO - Downloaded 989 bytes. 05:43:08 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 05:43:08 INFO - Using the following test package requirements: 05:43:08 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 05:43:08 INFO - u'common': [u'target.common.tests.zip'], 05:43:08 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 05:43:08 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 05:43:08 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 05:43:08 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 05:43:08 INFO - u'mozbase': [u'target.common.tests.zip'], 05:43:08 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 05:43:08 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 05:43:08 INFO - u'web-platform': [u'target.common.tests.zip', 05:43:08 INFO - u'target.web-platform.tests.tar.gz'], 05:43:08 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 05:43:08 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 05:43:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/THhrxJvGRaSBpbmI92T5WQ/artifacts/public/build/target.common.tests.zip 05:43:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/THhrxJvGRaSBpbmI92T5WQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:43:08 INFO - Fetch https://queue.taskcluster.net/v1/task/THhrxJvGRaSBpbmI92T5WQ/artifacts/public/build/target.common.tests.zip into memory 05:43:10 INFO - Content-Length response header: 55692212 05:43:10 INFO - Bytes received: 55692212 05:43:20 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 05:43:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/THhrxJvGRaSBpbmI92T5WQ/artifacts/public/build/target.common.tests.zip 05:43:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/THhrxJvGRaSBpbmI92T5WQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:43:20 INFO - Fetch https://queue.taskcluster.net/v1/task/THhrxJvGRaSBpbmI92T5WQ/artifacts/public/build/target.common.tests.zip into memory 05:43:21 INFO - Content-Length response header: 55692212 05:43:21 INFO - Bytes received: 55692212 05:43:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/THhrxJvGRaSBpbmI92T5WQ/artifacts/public/build/target.talos.tests.zip 05:43:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/THhrxJvGRaSBpbmI92T5WQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 05:43:34 INFO - Fetch https://queue.taskcluster.net/v1/task/THhrxJvGRaSBpbmI92T5WQ/artifacts/public/build/target.talos.tests.zip into memory 05:43:35 INFO - Content-Length response header: 14496665 05:43:35 INFO - Bytes received: 14496665 05:43:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:43:35 INFO - trying https://queue.taskcluster.net/v1/task/THhrxJvGRaSBpbmI92T5WQ/artifacts/public/build/target.tar.bz2 05:43:35 INFO - Downloading https://queue.taskcluster.net/v1/task/THhrxJvGRaSBpbmI92T5WQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 05:43:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/THhrxJvGRaSBpbmI92T5WQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 05:43:36 INFO - Downloaded 63485289 bytes. 05:43:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/THhrxJvGRaSBpbmI92T5WQ/artifacts/public/build/target.tar.bz2 05:43:36 INFO - mkdir: /builds/slave/test/properties 05:43:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:43:36 INFO - Writing to file /builds/slave/test/properties/build_url 05:43:36 INFO - Contents: 05:43:36 INFO - build_url:https://queue.taskcluster.net/v1/task/THhrxJvGRaSBpbmI92T5WQ/artifacts/public/build/target.tar.bz2 05:43:36 INFO - Running post-action listener: _resource_record_post_action 05:43:36 INFO - Running post-action listener: find_tests_for_verification 05:43:36 INFO - Running post-action listener: set_extra_try_arguments 05:43:36 INFO - [mozharness: 2017-09-07 12:43:36.647120Z] Finished download-and-extract step (success) 05:43:36 INFO - [mozharness: 2017-09-07 12:43:36.647216Z] Running populate-webroot step. 05:43:36 INFO - Running pre-action listener: _resource_record_pre_action 05:43:36 INFO - Running main action method: populate_webroot 05:43:36 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:43:36 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:43:36 INFO - 'tests': ['tresize', 05:43:36 INFO - 'tcanvasmark']}, 05:43:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:43:36 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:43:36 INFO - 'tests': ['dromaeo_css', 05:43:36 INFO - 'kraken']}, 05:43:36 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:43:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:43:36 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 05:43:36 INFO - 'talos_options': ['--disable-stylo'], 05:43:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:43:36 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:43:36 INFO - 'tests': ['damp', 'tps']}, 05:43:36 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 05:43:36 INFO - 'talos_options': ['--disable-stylo'], 05:43:36 INFO - 'tests': ['damp', 'tps']}, 05:43:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:43:36 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:43:36 INFO - 'tests': ['dromaeo_dom']}, 05:43:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 05:43:36 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:43:36 INFO - 'tests': ['basic_compositor_video', 05:43:36 INFO - 'glvideo']}, 05:43:36 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 05:43:36 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 05:43:36 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 05:43:36 INFO - 'talos_options': ['--disable-stylo'], 05:43:36 INFO - 'tests': ['ts_paint_webext', 05:43:36 INFO - 'tp5o_webext']}, 05:43:36 INFO - 'other-e10s': {'tests': ['a11yr', 05:43:36 INFO - 'ts_paint', 05:43:36 INFO - 'tpaint', 05:43:36 INFO - 'sessionrestore', 05:43:36 INFO - 'sessionrestore_many_windows', 05:43:36 INFO - 'sessionrestore_no_auto_restore', 05:43:36 INFO - 'tabpaint']}, 05:43:36 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:43:36 INFO - 'tests': ['a11yr', 05:43:36 INFO - 'ts_paint', 05:43:36 INFO - 'tpaint', 05:43:36 INFO - 'sessionrestore', 05:43:36 INFO - 'sessionrestore_many_windows', 05:43:36 INFO - 'sessionrestore_no_auto_restore', 05:43:36 INFO - 'tabpaint']}, 05:43:36 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 05:43:36 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 05:43:36 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:43:36 INFO - 'tests': ['bloom_basic_singleton']}, 05:43:36 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:43:36 INFO - 'tests': ['bloom_basic']}, 05:43:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:43:36 INFO - 'tsvgr_opacity', 05:43:36 INFO - 'tart', 05:43:36 INFO - 'tscrollx', 05:43:36 INFO - 'tsvg_static']}, 05:43:36 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:43:36 INFO - 'tests': ['tsvgx', 05:43:36 INFO - 'tsvgr_opacity', 05:43:36 INFO - 'tart', 05:43:36 INFO - 'tscrollx', 05:43:36 INFO - 'tsvg_static']}, 05:43:36 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:43:36 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 05:43:36 INFO - 'talos_options': ['--disable-stylo'], 05:43:36 INFO - 'tests': ['tp5o']}, 05:43:36 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:43:36 INFO - 'talos_options': ['--mitmproxy', 05:43:36 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:43:36 INFO - '--firstNonBlankPaint'], 05:43:36 INFO - 'tests': ['tp6_google', 05:43:36 INFO - 'tp6_youtube', 05:43:36 INFO - 'tp6_amazon', 05:43:36 INFO - 'tp6_facebook']}, 05:43:36 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:43:36 INFO - 'talos_options': ['--disable-stylo', 05:43:36 INFO - '--mitmproxy', 05:43:36 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:43:36 INFO - '--firstNonBlankPaint'], 05:43:36 INFO - 'tests': ['tp6_google', 05:43:36 INFO - 'tp6_youtube', 05:43:36 INFO - 'tp6_amazon', 05:43:36 INFO - 'tp6_facebook']}, 05:43:36 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:43:36 INFO - 'talos_options': ['--stylo-threads=1', 05:43:36 INFO - '--mitmproxy', 05:43:36 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:43:36 INFO - '--firstNonBlankPaint'], 05:43:36 INFO - 'tests': ['tp6_google', 05:43:36 INFO - 'tp6_youtube', 05:43:36 INFO - 'tp6_amazon', 05:43:36 INFO - 'tp6_facebook']}, 05:43:36 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:43:36 INFO - 'talos_options': ['--xperf_path', 05:43:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:43:36 INFO - 'tests': ['tp5n']}, 05:43:36 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 05:43:36 INFO - 'talos_options': ['--disable-stylo', 05:43:36 INFO - '--xperf_path', 05:43:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:43:36 INFO - 'tests': ['tp5n']}}} 05:43:36 INFO - Running post-action listener: _resource_record_post_action 05:43:36 INFO - [mozharness: 2017-09-07 12:43:36.662330Z] Finished populate-webroot step (success) 05:43:36 INFO - [mozharness: 2017-09-07 12:43:36.662421Z] Running create-virtualenv step. 05:43:36 INFO - Running pre-action listener: _resource_record_pre_action 05:43:36 INFO - Running main action method: create_virtualenv 05:43:36 INFO - Creating virtualenv /builds/slave/test/build/venv 05:43:36 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:43:36 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 05:43:36 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 05:43:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:43:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:43:37 INFO - Installing distribute.............................................................................................................................................................................................done. 05:43:37 INFO - Installing pip...............done. 05:43:37 INFO - Return code: 0 05:43:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:43:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:43:37 INFO - Reading from file tmpfile_stdout 05:43:37 INFO - Output received: 05:43:37 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 05:43:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:43:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:43:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:43:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:37 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 0x262c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2998a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299c090>, '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 0x299cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2996f90>, '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': '0e2a256762fed810e2f0f810000001b3-1504788184.137758-2072291508', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:43:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:43:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:43:37 INFO - Using env: {'DISPLAY': ':0', 05:43:37 INFO - 'HOME': '/home/cltbld', 05:43:37 INFO - 'LANG': 'en_US.UTF-8', 05:43:37 INFO - 'LANGUAGE': 'en_US:en', 05:43:37 INFO - 'LOGNAME': 'cltbld', 05:43:37 INFO - 'MAIL': '/var/mail/cltbld', 05:43:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:37 INFO - 'MOZ_NO_REMOTE': '1', 05:43:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:37 INFO - 'NO_EM_RESTART': '1', 05:43:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:37 INFO - 'PWD': '/builds/slave/test', 05:43:37 INFO - 'SHELL': '/bin/bash', 05:43:37 INFO - 'SHLVL': '1', 05:43:37 INFO - 'TERM': 'linux', 05:43:37 INFO - 'TMOUT': '86400', 05:43:37 INFO - 'USER': 'cltbld', 05:43:37 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1504788184.137758-2072291508', 05:43:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:37 INFO - '_': '/tools/buildbot/bin/python'} 05:43:38 INFO - Ignoring indexes: http://pypi.python.org/simple/ 05:43:38 INFO - Downloading/unpacking pip>=1.5 05:43:38 INFO - Running setup.py egg_info for package pip 05:43:38 INFO - warning: no files found matching 'pip/cacert.pem' 05:43:38 INFO - warning: no files found matching '*.html' under directory 'docs' 05:43:38 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 05:43:38 INFO - no previously-included directories found matching 'docs/_build/_sources' 05:43:38 INFO - Installing collected packages: pip 05:43:38 INFO - Found existing installation: pip 1.1 05:43:38 INFO - Uninstalling pip: 05:43:38 INFO - Successfully uninstalled pip 05:43:38 INFO - Running setup.py install for pip 05:43:38 INFO - warning: no files found matching 'pip/cacert.pem' 05:43:38 INFO - warning: no files found matching '*.html' under directory 'docs' 05:43:38 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 05:43:38 INFO - no previously-included directories found matching 'docs/_build/_sources' 05:43:38 INFO - Installing pip script to /builds/slave/test/build/venv/bin 05:43:38 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 05:43:38 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 05:43:38 INFO - Successfully installed pip 05:43:38 INFO - Cleaning up... 05:43:38 INFO - Return code: 0 05:43:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:43:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:43:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:43:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x262c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2998a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299c090>, '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 0x299cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2996f90>, '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': '0e2a256762fed810e2f0f810000001b3-1504788184.137758-2072291508', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:43:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:43:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:43:38 INFO - Using env: {'DISPLAY': ':0', 05:43:38 INFO - 'HOME': '/home/cltbld', 05:43:38 INFO - 'LANG': 'en_US.UTF-8', 05:43:38 INFO - 'LANGUAGE': 'en_US:en', 05:43:38 INFO - 'LOGNAME': 'cltbld', 05:43:38 INFO - 'MAIL': '/var/mail/cltbld', 05:43:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:38 INFO - 'MOZ_NO_REMOTE': '1', 05:43:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:38 INFO - 'NO_EM_RESTART': '1', 05:43:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:38 INFO - 'PWD': '/builds/slave/test', 05:43:38 INFO - 'SHELL': '/bin/bash', 05:43:38 INFO - 'SHLVL': '1', 05:43:38 INFO - 'TERM': 'linux', 05:43:38 INFO - 'TMOUT': '86400', 05:43:38 INFO - 'USER': 'cltbld', 05:43:38 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1504788184.137758-2072291508', 05:43:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:38 INFO - '_': '/tools/buildbot/bin/python'} 05:43:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:39 INFO - Downloading/unpacking psutil>=3.1.1 05:43:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:43:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:43:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:43:40 INFO - Installing collected packages: psutil 05:43:40 INFO - Running setup.py install for psutil 05:43:40 INFO - building 'psutil._psutil_linux' extension 05:43:40 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:43:40 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:43:40 INFO - building 'psutil._psutil_posix' extension 05:43:40 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:43:40 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:43:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:43:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:43:40 INFO - Successfully installed psutil 05:43:40 INFO - Cleaning up... 05:43:40 INFO - Return code: 0 05:43:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:43:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:43:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:43:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:40 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 0x262c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2998a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299c090>, '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 0x299cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2996f90>, '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': '0e2a256762fed810e2f0f810000001b3-1504788184.137758-2072291508', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:43:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:43:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:43:40 INFO - Using env: {'DISPLAY': ':0', 05:43:40 INFO - 'HOME': '/home/cltbld', 05:43:40 INFO - 'LANG': 'en_US.UTF-8', 05:43:40 INFO - 'LANGUAGE': 'en_US:en', 05:43:40 INFO - 'LOGNAME': 'cltbld', 05:43:40 INFO - 'MAIL': '/var/mail/cltbld', 05:43:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:40 INFO - 'MOZ_NO_REMOTE': '1', 05:43:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:40 INFO - 'NO_EM_RESTART': '1', 05:43:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:40 INFO - 'PWD': '/builds/slave/test', 05:43:40 INFO - 'SHELL': '/bin/bash', 05:43:40 INFO - 'SHLVL': '1', 05:43:40 INFO - 'TERM': 'linux', 05:43:40 INFO - 'TMOUT': '86400', 05:43:40 INFO - 'USER': 'cltbld', 05:43:40 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1504788184.137758-2072291508', 05:43:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:40 INFO - '_': '/tools/buildbot/bin/python'} 05:43:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:43:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:43:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:43:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:43:42 INFO - Installing collected packages: mozsystemmonitor 05:43:42 INFO - Running setup.py install for mozsystemmonitor 05:43:42 INFO - Successfully installed mozsystemmonitor 05:43:42 INFO - Cleaning up... 05:43:42 INFO - Return code: 0 05:43:42 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:43:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:43:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:43:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:42 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 0x262c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2998a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299c090>, '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 0x299cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2996f90>, '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': '0e2a256762fed810e2f0f810000001b3-1504788184.137758-2072291508', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:43:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:43:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:43:42 INFO - Using env: {'DISPLAY': ':0', 05:43:42 INFO - 'HOME': '/home/cltbld', 05:43:42 INFO - 'LANG': 'en_US.UTF-8', 05:43:42 INFO - 'LANGUAGE': 'en_US:en', 05:43:42 INFO - 'LOGNAME': 'cltbld', 05:43:42 INFO - 'MAIL': '/var/mail/cltbld', 05:43:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:42 INFO - 'MOZ_NO_REMOTE': '1', 05:43:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:42 INFO - 'NO_EM_RESTART': '1', 05:43:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:42 INFO - 'PWD': '/builds/slave/test', 05:43:42 INFO - 'SHELL': '/bin/bash', 05:43:42 INFO - 'SHLVL': '1', 05:43:42 INFO - 'TERM': 'linux', 05:43:42 INFO - 'TMOUT': '86400', 05:43:42 INFO - 'USER': 'cltbld', 05:43:42 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1504788184.137758-2072291508', 05:43:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:42 INFO - '_': '/tools/buildbot/bin/python'} 05:43:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:42 INFO - Downloading/unpacking jsonschema==2.5.1 05:43:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:43:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:43:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:43 INFO - Downloading functools32-3.2.3-2.tar.gz 05:43:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:43:43 INFO - warning: no files found matching '*.txt' 05:43:43 INFO - no previously-included directories found matching 'build' 05:43:43 INFO - no previously-included directories found matching 'dist' 05:43:43 INFO - no previously-included directories found matching '.git*' 05:43:43 INFO - Installing collected packages: jsonschema, functools32 05:43:43 INFO - Running setup.py install for functools32 05:43:43 INFO - warning: no files found matching '*.txt' 05:43:43 INFO - no previously-included directories found matching 'build' 05:43:43 INFO - no previously-included directories found matching 'dist' 05:43:43 INFO - no previously-included directories found matching '.git*' 05:43:43 INFO - Successfully installed jsonschema functools32 05:43:43 INFO - Cleaning up... 05:43:43 INFO - Return code: 0 05:43:43 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:43:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:43:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:43:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:43 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 0x262c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2998a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299c090>, '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 0x299cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2996f90>, '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': '0e2a256762fed810e2f0f810000001b3-1504788184.137758-2072291508', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:43:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:43:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:43:43 INFO - Using env: {'DISPLAY': ':0', 05:43:43 INFO - 'HOME': '/home/cltbld', 05:43:43 INFO - 'LANG': 'en_US.UTF-8', 05:43:43 INFO - 'LANGUAGE': 'en_US:en', 05:43:43 INFO - 'LOGNAME': 'cltbld', 05:43:43 INFO - 'MAIL': '/var/mail/cltbld', 05:43:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:43 INFO - 'MOZ_NO_REMOTE': '1', 05:43:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:43 INFO - 'NO_EM_RESTART': '1', 05:43:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:43 INFO - 'PWD': '/builds/slave/test', 05:43:43 INFO - 'SHELL': '/bin/bash', 05:43:43 INFO - 'SHLVL': '1', 05:43:43 INFO - 'TERM': 'linux', 05:43:43 INFO - 'TMOUT': '86400', 05:43:43 INFO - 'USER': 'cltbld', 05:43:43 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1504788184.137758-2072291508', 05:43:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:43 INFO - '_': '/tools/buildbot/bin/python'} 05:43:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:44 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:43:44 INFO - Cleaning up... 05:43:44 INFO - Return code: 0 05:43:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:43:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:43:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:43:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x262c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2998a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299c090>, '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 0x299cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2996f90>, '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': '0e2a256762fed810e2f0f810000001b3-1504788184.137758-2072291508', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:43:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:43:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:43:44 INFO - Using env: {'DISPLAY': ':0', 05:43:44 INFO - 'HOME': '/home/cltbld', 05:43:44 INFO - 'LANG': 'en_US.UTF-8', 05:43:44 INFO - 'LANGUAGE': 'en_US:en', 05:43:44 INFO - 'LOGNAME': 'cltbld', 05:43:44 INFO - 'MAIL': '/var/mail/cltbld', 05:43:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:44 INFO - 'MOZ_NO_REMOTE': '1', 05:43:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:44 INFO - 'NO_EM_RESTART': '1', 05:43:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:44 INFO - 'PWD': '/builds/slave/test', 05:43:44 INFO - 'SHELL': '/bin/bash', 05:43:44 INFO - 'SHLVL': '1', 05:43:44 INFO - 'TERM': 'linux', 05:43:44 INFO - 'TMOUT': '86400', 05:43:44 INFO - 'USER': 'cltbld', 05:43:44 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1504788184.137758-2072291508', 05:43:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:44 INFO - '_': '/tools/buildbot/bin/python'} 05:43:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:44 INFO - Downloading/unpacking blobuploader==1.2.4 05:43:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:45 INFO - Downloading blobuploader-1.2.4.tar.gz 05:43:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:43:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:43:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:43:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:43:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:46 INFO - Downloading docopt-0.6.1.tar.gz 05:43:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:43:46 INFO - Installing collected packages: blobuploader, requests, docopt 05:43:46 INFO - Running setup.py install for blobuploader 05:43:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:43:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:43:46 INFO - Running setup.py install for requests 05:43:46 INFO - Running setup.py install for docopt 05:43:46 INFO - Successfully installed blobuploader requests docopt 05:43:46 INFO - Cleaning up... 05:43:46 INFO - Return code: 0 05:43:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:43:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:43:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:43:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:46 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 0x262c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2998a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299c090>, '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 0x299cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2996f90>, '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': '0e2a256762fed810e2f0f810000001b3-1504788184.137758-2072291508', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:43:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:43:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:43:46 INFO - Using env: {'DISPLAY': ':0', 05:43:46 INFO - 'HOME': '/home/cltbld', 05:43:46 INFO - 'LANG': 'en_US.UTF-8', 05:43:46 INFO - 'LANGUAGE': 'en_US:en', 05:43:46 INFO - 'LOGNAME': 'cltbld', 05:43:46 INFO - 'MAIL': '/var/mail/cltbld', 05:43:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:46 INFO - 'MOZ_NO_REMOTE': '1', 05:43:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:46 INFO - 'NO_EM_RESTART': '1', 05:43:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:46 INFO - 'PWD': '/builds/slave/test', 05:43:46 INFO - 'SHELL': '/bin/bash', 05:43:46 INFO - 'SHLVL': '1', 05:43:46 INFO - 'TERM': 'linux', 05:43:46 INFO - 'TMOUT': '86400', 05:43:46 INFO - 'USER': 'cltbld', 05:43:46 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1504788184.137758-2072291508', 05:43:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:46 INFO - '_': '/tools/buildbot/bin/python'} 05:43:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:43:46 INFO - Running setup.py (path:/tmp/pip-o7qWJm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:43:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:43:47 INFO - Running setup.py (path:/tmp/pip-M6VksB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:43:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:43:47 INFO - Running setup.py (path:/tmp/pip-dzKarp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:43:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:43:47 INFO - Running setup.py (path:/tmp/pip-_gDylG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:43:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:43:47 INFO - Running setup.py (path:/tmp/pip-T7TQmT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:43:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:43:47 INFO - Running setup.py (path:/tmp/pip-173tX7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:43:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:43:47 INFO - Running setup.py (path:/tmp/pip-vecnVn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:43:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:43:47 INFO - Running setup.py (path:/tmp/pip-i6qRjN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:43:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:43:47 INFO - Running setup.py (path:/tmp/pip-Iarsqd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:43:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:43:47 INFO - Running setup.py (path:/tmp/pip-Tf5wkl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:43:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:43:47 INFO - Running setup.py (path:/tmp/pip-YqgYgu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:43:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:43:47 INFO - Running setup.py (path:/tmp/pip-oygMaL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:43:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:43:47 INFO - Running setup.py (path:/tmp/pip-OlEeuk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:43:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:43:47 INFO - Running setup.py (path:/tmp/pip-b8aeZH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:43:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:43:47 INFO - Running setup.py (path:/tmp/pip-dlB04M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:43:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:43:48 INFO - Running setup.py (path:/tmp/pip-ulpmKl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:43:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:43:48 INFO - Running setup.py (path:/tmp/pip-EOB0JI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:43:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:43:48 INFO - Running setup.py install for manifestparser 05:43:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:43:48 INFO - Running setup.py install for mozcrash 05:43:48 INFO - Running setup.py install for mozdebug 05:43:48 INFO - Running setup.py install for mozdevice 05:43:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:43:48 INFO - Running setup.py install for mozfile 05:43:48 INFO - Running setup.py install for mozhttpd 05:43:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:43:48 INFO - Running setup.py install for mozinfo 05:43:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:43:48 INFO - Running setup.py install for mozInstall 05:43:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:43:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:43:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:43:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:43:48 INFO - Running setup.py install for mozleak 05:43:49 INFO - Running setup.py install for mozlog 05:43:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:43:49 INFO - Running setup.py install for moznetwork 05:43:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:43:49 INFO - Running setup.py install for mozprocess 05:43:49 INFO - Running setup.py install for mozprofile 05:43:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:43:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:43:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:43:49 INFO - Running setup.py install for mozrunner 05:43:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:43:49 INFO - Running setup.py install for mozscreenshot 05:43:49 INFO - Running setup.py install for moztest 05:43:49 INFO - Running setup.py install for mozversion 05:43:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:43:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:43:49 INFO - Cleaning up... 05:43:49 INFO - Return code: 0 05:43:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:43:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:43:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:43:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:49 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 0x262c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2998a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299c090>, '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 0x299cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2996f90>, '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': '0e2a256762fed810e2f0f810000001b3-1504788184.137758-2072291508', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:43:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:43:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:43:49 INFO - Using env: {'DISPLAY': ':0', 05:43:49 INFO - 'HOME': '/home/cltbld', 05:43:49 INFO - 'LANG': 'en_US.UTF-8', 05:43:49 INFO - 'LANGUAGE': 'en_US:en', 05:43:49 INFO - 'LOGNAME': 'cltbld', 05:43:49 INFO - 'MAIL': '/var/mail/cltbld', 05:43:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:49 INFO - 'MOZ_NO_REMOTE': '1', 05:43:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:49 INFO - 'NO_EM_RESTART': '1', 05:43:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:49 INFO - 'PWD': '/builds/slave/test', 05:43:49 INFO - 'SHELL': '/bin/bash', 05:43:49 INFO - 'SHLVL': '1', 05:43:49 INFO - 'TERM': 'linux', 05:43:49 INFO - 'TMOUT': '86400', 05:43:49 INFO - 'USER': 'cltbld', 05:43:49 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1504788184.137758-2072291508', 05:43:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:49 INFO - '_': '/tools/buildbot/bin/python'} 05:43:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:43:50 INFO - Running setup.py (path:/tmp/pip-5J25Ku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:43:50 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:43:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:43:50 INFO - Running setup.py (path:/tmp/pip-tHJhec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:43:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:43:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:43:50 INFO - Running setup.py (path:/tmp/pip-qBRAMi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:43:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:43:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:43:50 INFO - Running setup.py (path:/tmp/pip-KM7DDX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:43:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:43:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:43:50 INFO - Running setup.py (path:/tmp/pip-xNgNpv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:43:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:43:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:43:50 INFO - Running setup.py (path:/tmp/pip-dfkSmL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:43:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:43:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:43:50 INFO - Running setup.py (path:/tmp/pip-XpnA_c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:43:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:43:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:43:50 INFO - Running setup.py (path:/tmp/pip-i3T62u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:43:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:43:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:43:50 INFO - Running setup.py (path:/tmp/pip-o3AY_A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:43:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:43:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:43:50 INFO - Running setup.py (path:/tmp/pip-WJPTmW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:43:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:43:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:43:50 INFO - Running setup.py (path:/tmp/pip-fcr407-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:43:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:43:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:43:50 INFO - Running setup.py (path:/tmp/pip-jAuFPq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:43:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:43:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:43:51 INFO - Running setup.py (path:/tmp/pip-bAfG5H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:43:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:43:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:43:51 INFO - Running setup.py (path:/tmp/pip-5lRGNH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:43:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:43:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:43:51 INFO - Running setup.py (path:/tmp/pip-Ln8P7_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:43:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:43:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:43:51 INFO - Running setup.py (path:/tmp/pip-ChC0AA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:43:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:43:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:43:51 INFO - Running setup.py (path:/tmp/pip-36agGN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:43:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:43:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:43:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:43:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:43:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:43:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:43:51 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:43:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:43:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:52 INFO - Downloading blessings-1.6.tar.gz 05:43:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:43:52 INFO - Installing collected packages: blessings 05:43:52 INFO - Running setup.py install for blessings 05:43:52 INFO - Successfully installed blessings 05:43:52 INFO - Cleaning up... 05:43:52 INFO - Return code: 0 05:43:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:43:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:43:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:43:52 INFO - Reading from file tmpfile_stdout 05:43:52 INFO - Current package versions: 05:43:52 INFO - argparse == 1.2.1 05:43:52 INFO - blessings == 1.6 05:43:52 INFO - blobuploader == 1.2.4 05:43:52 INFO - docopt == 0.6.1 05:43:52 INFO - functools32 == 3.2.3-2 05:43:52 INFO - jsonschema == 2.5.1 05:43:52 INFO - manifestparser == 1.1 05:43:52 INFO - mozInstall == 1.13 05:43:52 INFO - mozcrash == 1.0 05:43:52 INFO - mozdebug == 0.1 05:43:52 INFO - mozdevice == 0.51 05:43:52 INFO - mozfile == 1.2 05:43:52 INFO - mozhttpd == 0.7 05:43:52 INFO - mozinfo == 0.10 05:43:52 INFO - mozleak == 0.1 05:43:52 INFO - mozlog == 3.5 05:43:52 INFO - moznetwork == 0.27 05:43:52 INFO - mozprocess == 0.25 05:43:52 INFO - mozprofile == 0.28 05:43:52 INFO - mozrunner == 6.13 05:43:52 INFO - mozscreenshot == 0.1 05:43:52 INFO - mozsystemmonitor == 0.3 05:43:52 INFO - moztest == 0.8 05:43:52 INFO - mozversion == 1.4 05:43:52 INFO - psutil == 3.1.1 05:43:52 INFO - requests == 1.2.3 05:43:52 INFO - wsgiref == 0.1.2 05:43:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:43: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')]} 05:43:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43: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')]} 05:43:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:52 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 0x262c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2998a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299c090>, '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 0x299cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2996f90>, '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': '0e2a256762fed810e2f0f810000001b3-1504788184.137758-2072291508', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:43:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:43:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:43:52 INFO - Using env: {'DISPLAY': ':0', 05:43:52 INFO - 'HOME': '/home/cltbld', 05:43:52 INFO - 'LANG': 'en_US.UTF-8', 05:43:52 INFO - 'LANGUAGE': 'en_US:en', 05:43:52 INFO - 'LOGNAME': 'cltbld', 05:43:52 INFO - 'MAIL': '/var/mail/cltbld', 05:43:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:52 INFO - 'MOZ_NO_REMOTE': '1', 05:43:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:52 INFO - 'NO_EM_RESTART': '1', 05:43:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:52 INFO - 'PWD': '/builds/slave/test', 05:43:52 INFO - 'SHELL': '/bin/bash', 05:43:52 INFO - 'SHLVL': '1', 05:43:52 INFO - 'TERM': 'linux', 05:43:52 INFO - 'TMOUT': '86400', 05:43:52 INFO - 'USER': 'cltbld', 05:43:52 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1504788184.137758-2072291508', 05:43:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:52 INFO - '_': '/tools/buildbot/bin/python'} 05:43:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:43:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:43:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:43:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:43:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:43:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:43:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:43:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:43:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:43:53 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 05:43:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 05:43:54 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:43:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:43:54 INFO - Installing collected packages: simplejson 05:43:54 INFO - Running setup.py install for simplejson 05:43:54 INFO - building 'simplejson._speedups' extension 05:43:54 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 05:43:55 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 05:43:55 INFO - Successfully installed simplejson 05:43:55 INFO - Cleaning up... 05:43:55 INFO - Return code: 0 05:43:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:43:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:43:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:43:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x262c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2998a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299c090>, '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 0x299cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2996f90>, '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': '0e2a256762fed810e2f0f810000001b3-1504788184.137758-2072291508', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:43:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:43:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:43:55 INFO - Using env: {'DISPLAY': ':0', 05:43:55 INFO - 'HOME': '/home/cltbld', 05:43:55 INFO - 'LANG': 'en_US.UTF-8', 05:43:55 INFO - 'LANGUAGE': 'en_US:en', 05:43:55 INFO - 'LOGNAME': 'cltbld', 05:43:55 INFO - 'MAIL': '/var/mail/cltbld', 05:43:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:55 INFO - 'MOZ_NO_REMOTE': '1', 05:43:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:55 INFO - 'NO_EM_RESTART': '1', 05:43:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:55 INFO - 'PWD': '/builds/slave/test', 05:43:55 INFO - 'SHELL': '/bin/bash', 05:43:55 INFO - 'SHLVL': '1', 05:43:55 INFO - 'TERM': 'linux', 05:43:55 INFO - 'TMOUT': '86400', 05:43:55 INFO - 'USER': 'cltbld', 05:43:55 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1504788184.137758-2072291508', 05:43:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:55 INFO - '_': '/tools/buildbot/bin/python'} 05:43:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:43:55 INFO - Cleaning up... 05:43:55 INFO - Return code: 0 05:43:55 INFO - Running post-action listener: _resource_record_post_action 05:43:55 INFO - Running post-action listener: _start_resource_monitoring 05:43:55 INFO - Starting resource monitoring. 05:43:55 INFO - [mozharness: 2017-09-07 12:43:55.610346Z] Finished create-virtualenv step (success) 05:43:55 INFO - [mozharness: 2017-09-07 12:43:55.610810Z] Running install step. 05:43:55 INFO - Running pre-action listener: _resource_record_pre_action 05:43:55 INFO - Running main action method: install 05:43:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:43:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:43:55 INFO - Reading from file tmpfile_stdout 05:43:55 INFO - Detecting whether we're running mozinstall >=1.0... 05:43:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:43:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:43:55 INFO - Reading from file tmpfile_stdout 05:43:55 INFO - Output received: 05:43:55 INFO - Usage: mozinstall [options] installer 05:43:55 INFO - Options: 05:43:55 INFO - -h, --help show this help message and exit 05:43:55 INFO - -d DEST, --destination=DEST 05:43:55 INFO - Directory to install application into. [default: 05:43:55 INFO - "/builds/slave/test"] 05:43:55 INFO - --app=APP Application being installed. [default: firefox] 05:43:55 INFO - mkdir: /builds/slave/test/build/application 05:43:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:43:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 05:44:12 INFO - Reading from file tmpfile_stdout 05:44:12 INFO - Output received: 05:44:12 INFO - /builds/slave/test/build/application/firefox/firefox 05:44:12 INFO - Running post-action listener: _resource_record_post_action 05:44:12 INFO - [mozharness: 2017-09-07 12:44:12.324314Z] Finished install step (success) 05:44:12 INFO - [mozharness: 2017-09-07 12:44:12.324461Z] Running setup-mitmproxy step. 05:44:12 INFO - Running pre-action listener: _resource_record_pre_action 05:44:12 INFO - Running main action method: setup_mitmproxy 05:44:12 INFO - Skipping: mitmproxy is not required 05:44:12 INFO - Running post-action listener: _resource_record_post_action 05:44:12 INFO - [mozharness: 2017-09-07 12:44:12.324994Z] Finished setup-mitmproxy step (success) 05:44:12 INFO - [mozharness: 2017-09-07 12:44:12.325196Z] Running run-tests step. 05:44:12 INFO - Running pre-action listener: _resource_record_pre_action 05:44:12 INFO - Running pre-action listener: _set_gcov_prefix 05:44:12 INFO - Running main action method: run_tests 05:44:12 WARNING - Try message not found. 05:44:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:44:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:44:12 INFO - Python 2.7.3 05:44:12 INFO - Return code: 0 05:44:12 INFO - grabbing minidump binary from tooltool 05:44:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:44:12 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 0x299c090>, '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 0x299cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2996f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:44:12 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:44:12 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:44:12 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:44:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:44:12 INFO - Return code: 0 05:44:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:44:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:44:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:44:12 INFO - ENV: RUST_BACKTRACE is now full 05:44:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:44:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:44:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/THhrxJvGRaSBpbmI92T5WQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] in /builds/slave/test/build 05:44:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/THhrxJvGRaSBpbmI92T5WQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-058 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log 05:44:12 INFO - Using env: {'DISPLAY': ':0', 05:44:12 INFO - 'HOME': '/home/cltbld', 05:44:12 INFO - 'LANG': 'en_US.UTF-8', 05:44:12 INFO - 'LANGUAGE': 'en_US:en', 05:44:12 INFO - 'LOGNAME': 'cltbld', 05:44:12 INFO - 'MAIL': '/var/mail/cltbld', 05:44:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:44:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:44:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:44:12 INFO - 'MOZ_NO_REMOTE': '1', 05:44:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:44:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:44:12 INFO - 'NO_EM_RESTART': '1', 05:44:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:44:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:44:12 INFO - 'PWD': '/builds/slave/test', 05:44:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:44:12 INFO - 'RUST_BACKTRACE': 'full', 05:44:12 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 05:44:12 INFO - 'SHELL': '/bin/bash', 05:44:12 INFO - 'SHLVL': '1', 05:44:12 INFO - 'TERM': 'linux', 05:44:12 INFO - 'TMOUT': '86400', 05:44:12 INFO - 'USER': 'cltbld', 05:44:12 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1504788184.137758-2072291508', 05:44:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:44:12 INFO - '_': '/tools/buildbot/bin/python'} 05:44:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/THhrxJvGRaSBpbmI92T5WQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] with output_timeout 3600 05:44:12 INFO - mozversion application_buildid: 20170907103107 05:44:12 INFO - mozversion application_changeset: 6469a2cb7df662afb23493b5566f99b6802fcb5a 05:44:12 INFO - mozversion application_display_name: Nightly 05:44:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:44:12 INFO - mozversion application_name: Firefox 05:44:12 INFO - mozversion application_remotingname: firefox 05:44:12 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:44:12 INFO - mozversion application_vendor: Mozilla 05:44:12 INFO - mozversion application_version: 57.0a1 05:44:12 INFO - mozversion platform_buildid: 20170907103107 05:44:12 INFO - mozversion platform_changeset: 6469a2cb7df662afb23493b5566f99b6802fcb5a 05:44:12 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:44:12 INFO - mozversion platform_version: 57.0a1 05:44:12 INFO - using testdate: 1504788252 05:44:12 INFO - actual date: 1504788252 05:44:12 INFO - starting webserver on 'localhost:57477' 05:44:12 INFO - SUITE-START | Running 2 tests 05:44:12 INFO - TEST-START | dromaeo_css 05:44:12 INFO - Initialising browser for dromaeo_css test... 05:44:12 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:57477/getInfo.html -profile /tmp/tmp48BaFF/profile 05:44:12 INFO - TEST-INFO | started process 5588 (/builds/slave/test/build/application/firefox/firefox http://localhost:57477/getInfo.html) 05:44:18 INFO - TEST-INFO | 5588: exit 0 05:44:18 INFO - Browser initialized. 05:44:18 INFO - Running cycle 1/1 for dromaeo_css test... 05:44:18 INFO - Using env: {'DISPLAY': ':0', 05:44:18 INFO - 'HOME': '/home/cltbld', 05:44:18 INFO - 'JSGC_DISABLE_POISONING': '1', 05:44:18 INFO - 'LANG': 'en_US.UTF-8', 05:44:18 INFO - 'LANGUAGE': 'en_US:en', 05:44:18 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 05:44:18 INFO - 'LOGNAME': 'cltbld', 05:44:18 INFO - 'MAIL': '/var/mail/cltbld', 05:44:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:44:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:44:18 INFO - 'MOZ_CRASHREPORTER': '1', 05:44:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:44:18 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 05:44:18 INFO - 'MOZ_NO_REMOTE': '1', 05:44:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:44:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:44:18 INFO - 'NO_EM_RESTART': '1', 05:44:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:44:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:44:18 INFO - 'PWD': '/builds/slave/test', 05:44:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:44:18 INFO - 'RUST_BACKTRACE': 'full', 05:44:18 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 05:44:18 INFO - 'SHELL': '/bin/bash', 05:44:18 INFO - 'SHLVL': '1', 05:44:18 INFO - 'STYLO_FORCE_DISABLED': '1', 05:44:18 INFO - 'TERM': 'linux', 05:44:18 INFO - 'TMOUT': '86400', 05:44:18 INFO - 'USER': 'cltbld', 05:44:18 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1504788184.137758-2072291508', 05:44:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:44:18 INFO - '_': '/tools/buildbot/bin/python'} 05:44:18 INFO - TEST-INFO | started process 5785 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp48BaFF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:44:19 INFO - PID 5785 | 05:44:19 INFO - PID 5785 | (/builds/slave/test/build/application/firefox/firefox:5837): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 05:44:19 INFO - PID 5785 | 05:44:29 INFO - PID 5785 | RSS: Main: 162373632 05:44:29 INFO - PID 5785 | 05:47:26 INFO - PID 5785 | Cycle 1(1): loaded http://localhost:57477/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57477/tests/dromaeo/cssquery-ext.html) 05:47:27 INFO - PID 5785 | RSS: Main: 165310464 05:47:27 INFO - PID 5785 | 05:50:29 INFO - PID 5785 | Cycle 1(1): loaded http://localhost:57477/tests/dromaeo/cssquery-ext.html (next: http://localhost:57477/tests/dromaeo/cssquery-jquery.html) 05:50:29 INFO - PID 5785 | RSS: Main: 161304576 05:50:29 INFO - PID 5785 | 05:53:31 INFO - PID 5785 | Cycle 1(1): loaded http://localhost:57477/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57477/tests/dromaeo/cssquery-mootools.html) 05:53:31 INFO - PID 5785 | RSS: Main: 163577856 05:53:31 INFO - PID 5785 | 05:56:33 INFO - PID 5785 | Cycle 1(1): loaded http://localhost:57477/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57477/tests/dromaeo/cssquery-prototype.html) 05:56:34 INFO - PID 5785 | RSS: Main: 162398208 05:56:34 INFO - PID 5785 | 05:59:37 INFO - PID 5785 | Cycle 1(1): loaded http://localhost:57477/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57477/tests/dromaeo/cssquery-yui.html) 05:59:37 INFO - PID 5785 | RSS: Main: 163418112 05:59:37 INFO - PID 5785 | 06:02:39 INFO - PID 5785 | Cycle 1(1): loaded http://localhost:57477/tests/dromaeo/cssquery-yui.html (next: http://localhost:57477/tests/dromaeo/cssquery-dojo.html) 06:02:39 INFO - PID 5785 | RSS: Main: 166162432 06:02:39 INFO - PID 5785 | 06:02:39 INFO - PID 5785 | __start_tp_report 06:02:39 INFO - PID 5785 | _x_x_mozilla_page_load 06:02:39 INFO - PID 5785 | _x_x_mozilla_page_load_details 06:02:39 INFO - PID 5785 | |i|pagename|runs| 06:02:39 INFO - PID 5785 | |0;dojo.html;3843.3850583906565;3864.323743344915;3886.8445262189507;3911.29596672599;3912.8826135215954;6357.110004599348;6369.968150159249;6419.839504012396;6424.325445828191;6435.742570297189;6234.0648902664625;6336.239651241846;6342.714577843996;6352.491800655948;6378.298387177419;5682.431756824305;5705.343885453164;5709.143628455734;5715.485606295432;5737.311522617292;5731.512821410185;5754.079347304432;5767.106098554731;5768.105943578752;5787;5723.742431590567;5751.079827227644;5770.624909380897;5780.595358324919;5787.681677507735;5669.348024977139;5807.941920580783;5816.534677225812;5826.708664566797;5830.446107619811;5637.915431268534;5712.22884910536;5726.713664316809;5741.425857414267;5741.741621627037;5830.300363956352;6213.5961162524745;6269.153664255358;6285.465735412496;6331.8733625327695;6901.516893817435;6912.619805910673;6916.515843890929;6928.61892595907;6944.305569443066;6929.618870962095;7009.894851577231;7010.193827709828;7014.403775679073;7026.086608740831;6371.617702937839;6372.776952806676;6389.9680501597195;6471.935280647181;6481.384268494486;6994.8950765738555;7083.18543367509;7091.184513780878;7095.929040709527;7101.183363913216;6780.525363224527;6821.590704557643;6822.044913711985;6852.554583952027;6868.828279292958;6873.793786186422;6880.8967865482055;6883.242843287235;6968.860622787516;6969.30306969299;6827.0783444235385;6831.2144103427745;6911.516193866381;6913.308669133046;6925.688344024531;6782.93217067823;6829.658517074126;6848.075509806212;6880.931190688129;6910.896336554955;4995.150824359867;5025.497450254945;5057.418396884332;5071.061853557104;5084.161113416245;4540.318952157137;4574.794134263966;4576.725396476222;4590.839320623762;4598.195315819718;6264;6285.59143655661;6294.307626161119;6352.237731472253;6396.200474940632;6799.422049125781;6838.692258848364;6838.974153876959;6844;6850.143732033496;6326.652034138075;6337.2395312562785;6338.271098823602;6338.524610654219;6354.26925903527;5464.836054918359;5560.527355174855;5582.413846546136;5599.384067752544;5604.327480702342;7166.04306563915;7171.784846454615;7260.528065675714;7263.818404539823;7275.345218930322;6725.058491811248;6749;6799.660016999229;6805.2173999989645;6888.517803753789;7090.361867431956;7172.390346820579;7187.389071928736;7191.568505889663;7193.2087470379265;6753.358430949052;6823.93176068233;6827.692753825991;6838.658067096526;6843.349881761224;6785.898211526733;6806.523543352116;6868.896966545406;6886.070380498769;6983.301669832976;6460.580062296123;6553.836154096186;6574.3754343337305;6634.734610615521;6652.73389064432;6644.202695676549;6696.1629796275465;6702;6706.932930670826;6711.194656641234;6533.509986751108;6613.603183808987;6628.76799312041;6634.83412914681;6703.363180497845;6626.97281921303;6664.83337916556;6669.333066693486;6685.465162787063;6814.1482314710665;6401.391867772554;6501.9674901625185;6517.022446633043;6564.901526477202;6566.376194261537 06:02:39 INFO - PID 5785 | |1;ext.html;800.6877317846038;865.5066612031142;891.0198781340524;896.5024411451645;1227.2145826670937;31856.681433185662;32646.347073058554;41788.37317440237;41914.790426047904;42438;42524;43013.78493107538;43021.78489107558;43194.784026079826;43215.13569728604;7649.92350076499;7976.361891048731;8171.387145964047;8173.182681731839;8174.26431621154;7976.641051152712;8062.395320350997;8072.3138533224455;8075.434719569633;8085.636146373427;8024.077231118408;8095.392845536609;8095.757127286191;8099.230573095576;8105.959470202641;8059.838803223932;8087.878681819778;8096.190380961915;8111.959440202821;8115.594220288962;7728.845423091563;7749.225077492262;7779.066512018594;7810.258025487569;7816.960915195445;38479.80760096209;38670.419943700865;38710.80644596759;38714.61285387138;38719.61280387188;3678.9632103678887;3747.625237476258;3751.6998640109;3751.756135851161;3752.061984503874;33062.17344566381;33121;33172.50241246383;33181.83409082963;33221.6677833221;5311.814086506954;5373.6775793452125;5445.945540544623;5462.6995515247045;5494.670319780826;215292;216037;217070.91464542734;217753;217938;52138.21792673113;52326.47673523292;52370.21444678333;52394;52418.47581524212;56477.71761141168;57533;57615.71192144096;57629;57640.13539796906;15106.169160696047;15379.384824607114;16734.66530669404;16741.6651666966;16839.158042097846;13583.388747506386;13817.170969741848;13833.377498012613;13836.515721949885;13845.376958036912;15155.469558565397;15227;15271.236438178268;15279;15418.460353887784;5572.498475137257;5749.85625359361;5868.383819698955;5938.168656388109;5965.926133296049;1066.7866426714534;1089.9782004359868;1090.820014697566;1092.3991804507489;1095.2880627592128;25809.61285580718;25858.319867536622;26143.346416339362;26413.867930660606;26456.867715661298;1193.146899966528;1200.543793358518;1200.9219400738923;1202.5670758526924;1215.671768622467;13423.530176443777;13506.59480215595;13554.728905421836;13575.524856630169;13771.655708607164;288033;289692;290023;290361;291642;55358.723206384515;55656.721716391155;55699.443005569425;55780.88438231213;55831.44168558263;1488.642725745813;1495.7532007218904;1513.3265696765054;1522.079142119002;1533.2333833083458;24837.339463295477;24901;25067.093130762743;25096.874515627303;25403.74596254014;39800.2039959205;39803;39899;39947.201055978134;39975.80012099921;242641;243002;243040;243388;243884;34744.82627586846;39130;39582.40626390549;39618.20763584654;39629.40555891721;48039.51960480351;48127;48225;49109.2633610489;49399.25901111558;36495;36709.44935825912;36820;36976.81511592425;37068.629313706515;36737.632623673424;36799.632003680694;36860.447093293085;37081.44377834281;37114;41734.37398439086;41779.58220417878;41998;42276.15447690967;42279.788601056796;35013.47479787754;35017.299654007285;35101.824490877385;35136.82431587826;35517.28965420625;25949.740502594734;26268.60597091007;26571.468570628094;26803.927842886067;27044.864775675996 06:02:39 INFO - PID 5785 | |2;jquery.html;599.1641659884461;600.9681158555092;601.3145014683262;606.3239487970914;615.8829822333756;22223.333300000984;22695.886520567416;22714.318570442912;22988.88505557472;23022.769772302272;26530.204093877215;26754.732452675467;27119.1864244073;27133.86433067832;27206;6495.837604059889;6687.264400915896;6698;6698.8995165072565;6733;5909.084091965752;6590.967045164767;6596.076549283104;6604.834879128036;6606.6036037837885;6556.08214849919;6569.934300657004;6584.144061272052;6597.142371491724;6601.306862779411;6543.93456065438;6548.377904099103;6555.082288479617;6563.245226798931;6563.704633291513;6078.665673387962;6087.665178415185;6106.938930610726;6142.754289828402;6145.139680444741;29749.256268593243;30143.849280753675;30660.2334941626;30690.693093069007;30904.381912361852;2219.9889000554895;2250.718660167479;2254.211026140854;2261.2537862505333;2266.7733226677365;19693.21227150912;19943.401697949084;20879.895600522053;20920.267790627408;20966;2506.448581312127;2518.987405062963;2526.621006848969;2538.4669219463935;2591.753783390575;152433;152519.23740381337;158052;158778;159189;15677.686446271238;16008.519744407686;16278.918605407134;16335.346586136659;16388;26402.73597264003;26409.73590264111;26420.603690944652;26459.206223813315;26495.867520662272;10634.308769930085;11044.613438529774;11081.833772493419;11091.778164436666;11113.722156946142;10017.098461138532;10019;10096.848547271797;10101.797964040677;10220.795584088277;9794.118529332394;9831.360961537477;9997.200223982063;10012.39925604466;10220.540075696463;2884.5528943013865;2967.5251959686348;2969.346743716422;2990.551417287424;3017.109952563999;1061.8460323253084;1066.226985435553;1067.3062509368972;1069.5240617924949;1092.4537731134433;21641.675374869388;21739;21869.890650546644;21885.67171492429;22028.008739606757;1134.4838098665089;1136.5681041204455;1146.1747541769912;1158.8493495845487;1164.63896192179;11669.591564295379;14299;14337.426502939765;14982.250887455584;15220.695586088215;631836;633821;636997;638428;651958;134027;134806;135115;136998;137296.31351843377;1291.4188615123232;1297.8961683065331;1340.2963444191878;1342.8657134286689;1347.3532704302186;22239.555208896054;22488.887555562116;22671;22739.317820465414;22921.77078229263;61086.38913610807;62665;62954;64061;64167;76579.23420765721;77516.61241693755;77572;78122;78171.6091419562;15299.847001530288;15514.14672192995;15634.843651563338;15726.370945162065;15821.288042038366;24539.87730061338;24559.63160552629;24804.627930580697;24861.254162375157;24862.627060593742;19265;19760.505987350432;19829.702554461983;20235.898820505805;20247.29134480286;17168.914155429644;17270.654586908444;17350.91324543369;17758.644827103126;18066.638667226845;19525.316613918443;19757.407277781116;19949.700754488404;20003.799962000194;20292.59414811725;14684.926575367055;15170.31733572014;15314.770278446054;15469.381224750883;15525;19521.316753913547;19618.705719414505;19639.70540441923;19767.802321976596;19847.60304793867 06:02:39 INFO - PID 5785 | |3;mootools.html;1407.9507217247394;1452.941882324707;1455.2141843404556;1456.4829485532637;1461.729580027695;16241.756373654405;16365.918170409146;16998.320067197314;17027.91486042571;17046.488605341827;17021.744673829904;17309.567260818487;17316.220770065345;17321;17364.479065628053;2887.653481582213;2927.19502136913;2927.531594944809;2927.88288468461;2930.4578652949167;2832.5978640572944;2911;2911.5487099499505;2911.985440072797;2915.11089117819;2824.8305101693863;2853.1012730989773;2855.771538276933;2856.6143570618015;2858.5283428234316;2759.4894944435346;2829.038127036807;2830.3207230264793;2835.2911772056987;2835.673897501793;2798.3423895384567;2827.816191947517;2835.6597208334924;2837.702041285656;2839.3895312507702;16099.517014489584;16189.676206475922;16357.672846543002;16372.83627163725;16381.672366552602;8482.363822713321;8785.341099417505;8801.251893589053;8826.382153249275;8853.822923541558;5378.085725426687;5526.336839579236;5725;5751.332113687067;5761.769529218826;2067.5348046689373;2115.982016137837;2141.0793358855685;2158.2230397057047;2173.3914503938922;29816.8509157455;29906;29923.251918702208;30044.098677039507;30070.24824379386;7151;7294.343509084208;7360.852782944311;7447.515911465737;7530.359919406802;19101.140448679842;19138;19166.80833191678;19181.424557263304;19198;8285.50286982783;8437.915620843713;8442.873356899652;8443.197896199852;8449.112843151504;6609;6855.348741869514;7066.646667666596;7992.760217193493;8018.639161237758;5457.918131228034;5676.914846277309;5700.059490184156;5712.742926568314;5812.070068789058;1558.3688606114542;1559.2125976381853;1583.5407731757891;1594.6332343560814;1598.7042397156563;965.232640051161;996.1632228927591;998.2313618513704;1000.5047501486665;1020.1481762728205;8596.699115530926;8650.52422116777;8653.307735381155;8712.869306960401;8771.254443372385;767.098659075584;768.5772824946257;769.6459628570808;774.0865778381564;774.9151188336261;5162.502874166525;5886.234789477427;6039.245094363205;6046.244219472566;6257.4681152102585;24185;25296;25440;25440;25453;23611.29166125019;24493;24770;24892.377690557518;24977;11949;11980.22128561658;12246.81629775554;12256.632301030982;12270.81593776094;9482.620695172393;9510.47692376926;9532.428054316762;9551;9624.326297159132;20853;20929.476763081046;21018.2643607473;21394.893025534773;21563.46091347666;21707.348779536638;22154.22460213885;22310;22415.32754017382;22848.428789279737;13496.190228586316;13540.119892206974;13668.52160174389;13857.237851918242;13861.168329900238;15502.224888755743;15634.140122293384;15635.29641166173;15643.061416314602;15654.843451565794;12569.245845249314;12709.936450318059;12794.68013299675;12889.8066529004;12899.871001289866;11907.226030308002;11973.401329933642;12065.879341206475;12141.150119491904;12523.248605083723;10701.197410194422;10965.067969222386;10996.945015274872;11006.119510439306;11012.119030477703;8049.072411729457;8203.753887383387;8211.425200235926;8238.670453181805;8252.752417427488;8094.51432914027;8176.550289733884;8213.671453142046;8229.835403291781;8282.254597086292 06:02:39 INFO - PID 5785 | |4;prototype.html;547.4142667345941;564.4045531963776;577.1256546332307;578.8263520943716;583.1573376470999;6091.421314975081;6092.451679348857;6110.663913484756;6211.130441738149;6224.470919971802;6016.75932962681;6072;6073.904502946476;6138.294096178941;6151.81544553663;5040.916203016351;5045.217991211368;5052.873678158038;5059.443461219263;5077.669951453162;4835.492273311304;4904.460509343987;4957.603391728671;4972.25416187573;5028.597712183035;4773.212419950704;4814.7833347499445;4844.297576851354;4863.537963893425;4897.118518666639;4838.685485443452;4851.738547977516;4881.365422495053;4901.705897646153;4906.484819094015;4360.21516127097;4414.84548040817;4421.778911054466;4432.84485043022;4462;5905.106497816082;5926.844265368255;5994.700264986734;6006.279246490449;6021.307549631804;5660.179274005287;5723.484886360206;5726.141078838166;5730.34101078373;5786.553361659585;6540.509461790337;6558;6570.277269500351;6594.274629790719;6594.604323740591;4916.926246106311;4941.308216849644;4961.206207006898;4979.775910084055;4988.625853061035;6623.834404139935;6709.966450167718;6737.898931516032;6824.1469816272465;6878.457594338919;4948.455669876311;5064.974675126601;5090.872728181751;5127;5130.589552835764;5177.792888284502;5184.585233181337;5203.453637368098;5210.609204309692;5234.293370395024;5742.13867919807;5751.281089863767;5782.624129431573;5786.103154011135;5800.187973683687;6609.1408116944485;6650.53446258767;6653.434458071021;6664.566803157876;6664.800335939577;1807.5842556212144;1811.4203454894307;1814.4193857965324;1836.3389179895228;1838.6874231380698;1247.9500819967282;1280.4494067550856;1292.8190053392532;1295.5724610878387;1295.7214198947272;6141.7543298268465;6150.354212807591;6187.504999600022;6199.442050215503;6208.627482351073;6376.266729326187;6674.399304062561;6695.12963314766;6709.194896612437;6750.426213771786;5934.465898069108;5945.464908158287;6059.8485037873525;6060.363661815534;6100.206973093469;3482.46021866606;3508.1054331145906;3516.3318969396246;3519.59524654668;3523.665251801126;6891.758788442481;6905.964105384132;6922.653867306614;6936.375726184668;6967.342145373719;6753.750556147129;6776.2546119926765;6840.555363901331;6843.863122737617;6879.58722476653;6925.065116209247;6943.72225111;6949.409300209438;6970.849809781431;6971.82570435733;6443.194600674916;6588.37410446026;6598.934010659832;6608.867822643617;6620.966895165493;6415.390537898892;6416.299680584742;6471.579347342407;6524.510661700487;6585.012248162814;6846.178458585002;6870.213744426385;6911.89632155508;6971.6862741175755;7014.2635023323855;5130;5140.73807524688;5145.151050076845;5151.124308867426;5172.379314482136;6360.236771587439;6540.705668245036;6633;6671.866562668816;6728.8654226914205;6300.495960323072;6334.429901308904;6338.11266422692;6361.395667411589;6386.517684550093;6320.304766475592;6353.459955903615;6380.500582363234;6403.807885763435;6413.16628838248;6266.717997690206;6373.553851230555;6378.77674281398;6417.005364168562;6435.517336199898;6412.294647588668;6462.515311351762;6462.612243265419;6473.640535487412;6477.222733272038;6215.254169499689;6273;6300.7479700811455;6324.778632747832;6362.459190968634 06:02:39 INFO - PID 5785 | |5;yui.html;954.4130359828707;959.7888464537801;975.790205105902;978.9853152202722;992.4938281476448;20314.492137696565;20460.59078818423;20778.16887324509;20859.582808343843;21401.46496337592;22228;22508.88745556274;22643.54712905741;22644.88677556614;22690.319290421274;1013;1051.5530899367777;1052.1740433759462;1052.5211028981794;1053.6470282455386;1076.8277075667895;1123.3989815448735;1124.0557931337717;1124.3085502415995;1125.5104029747085;1159.5825502818977;1162.9069674426025;1162.970925726855;1163.2438914705424;1166.1603645375317;1155.7919574476591;1156.4738044189914;1158.1140427572914;1158.6697791129488;1164.126904821384;853.3301358433599;853.7225401744458;853.906070332263;855.0210009539105;859.4499520307008;19304.61390772191;19620.509487262934;19684.409467715992;20567.280145194847;21288.361349159397;23145.189918352946;23212.18757343485;23249.883750581306;23423.297301080995;23724.40688982772;17384.391546295945;17632.91183544074;17685.734713979302;17929;18034.90982545092;4020.316546187126;4059.8985025374304;4060.3909413587903;4061.4110953911813;4063.065494936181;141659.99999999898;142722;144735;146399;146588.26705866403;17321.7401738974;17440.738388924176;17549.12254387301;17720.645587088187;17728.202230899384;33517.32965340679;34086.82956585251;34486.82756586201;34526.48210276848;34600.48099278513;9026.819463610691;9119.270458363315;9148.313876459291;9151.862722059175;9160.679376221933;4109.938350924738;4801.95198048022;4823.204171311764;4841.564259216688;4842.346283251716;6377.23473183221;6573.934260657428;6649;6680.766173183915;6689.264180940093;1158.6697791129657;1216.555957075661;1232.6302109367155;1240.4232032105115;1244.8381710377594;677.6814896998403;692.3595674001629;709.3013381818904;715.8675645005691;739.7928579997609;12708.618741437771;14346.713065738626;14456.566303010926;15151.166685832164;15695.764563531557;637.4040272345372;700.5901547594714;734.9669264882987;740.6629983357559;758.1963119093779;6266.373362663697;6636.83407914806;6689.163854518185;6900.689468973908;6927.596474749704;126167;127232;129031.35484322518;132705;133156;104852;110675;112070;112967.43516282366;114963;99854;100272.49863750635;101340.49329753451;101923.49038254909;105914;13919.652008699864;14136.363863625957;14176;14262.500812471513;14298.499552515612;49997;50443.747781260856;50883.49116508788;50909.490905090475;51362;64205;64683.35316646961;65149.674251628436;66535;66590.33409665841;18809.811901880807;20069.297574585402;20663.793362066186;20799.480012999797;20863.79136208679;22454.32637020892;22575.209867654554;22608.208712694977;22705.88647056754;22722.43193920165;19682.60634787325;19951.700724488855;21769.782302176776;22032.11871525121;22085.889570552044;19488.415347539598;19726.40820775379;19776.40670779879;19811.504712382306;19846.90076549666;20270;20378.79621203769;20949.476263092936;20974.2659006934;21009.054592543678;14627.19550424737;14762.704745905237;14954.775678364616;15132;15703.057816531045;15791.68416631638;16109.113998730183;16308.266128024505;16322.59193520124;16336.264868081202 06:02:39 INFO - PID 5785 | __end_tp_report 06:02:39 INFO - PID 5785 | __start_cc_report 06:02:39 INFO - PID 5785 | _x_x_mozilla_cycle_collect,354 06:02:39 INFO - PID 5785 | __end_cc_report 06:02:39 INFO - PID 5785 | __startTimestamp1504789359596__endTimestamp 06:02:39 INFO - PID 5785 | 06:02:39 INFO - PID 5785 | ------- Summary: start ------- 06:02:39 INFO - PID 5785 | Number of tests: 6 06:02:39 INFO - PID 5785 | 06:02:39 INFO - PID 5785 | [#0] dojo.html Cycles:165 Average:6335.26 Median:6566.38 stddev:752.61 (11.5%) stddev-sans-first:729.09 06:02:39 INFO - PID 5785 | Values: 3843.4 3864.3 3886.8 3911.3 3912.9 6357.1 6370.0 6419.8 6424.3 6435.7 6234.1 6336.2 6342.7 6352.5 6378.3 5682.4 5705.3 5709.1 5715.5 5737.3 5731.5 5754.1 5767.1 5768.1 5787.0 5723.7 5751.1 5770.6 5780.6 5787.7 5669.3 5807.9 5816.5 5826.7 5830.4 5637.9 5712.2 5726.7 5741.4 5741.7 5830.3 6213.6 6269.2 6285.5 6331.9 6901.5 6912.6 6916.5 6928.6 6944.3 6929.6 7009.9 7010.2 7014.4 7026.1 6371.6 6372.8 6390.0 6471.9 6481.4 6994.9 7083.2 7091.2 7095.9 7101.2 6780.5 6821.6 6822.0 6852.6 6868.8 6873.8 6880.9 6883.2 6968.9 6969.3 6827.1 6831.2 6911.5 6913.3 6925.7 6782.9 6829.7 6848.1 6880.9 6910.9 4995.2 5025.5 5057.4 5071.1 5084.2 4540.3 4574.8 4576.7 4590.8 4598.2 6264.0 6285.6 6294.3 6352.2 6396.2 6799.4 6838.7 6839.0 6844.0 6850.1 6326.7 6337.2 6338.3 6338.5 6354.3 5464.8 5560.5 5582.4 5599.4 5604.3 7166.0 7171.8 7260.5 7263.8 7275.3 6725.1 6749.0 6799.7 6805.2 6888.5 7090.4 7172.4 7187.4 7191.6 7193.2 6753.4 6823.9 6827.7 6838.7 6843.3 6785.9 6806.5 6868.9 6886.1 6983.3 6460.6 6553.8 6574.4 6634.7 6652.7 6644.2 6696.2 6702.0 6706.9 6711.2 6533.5 6613.6 6628.8 6634.8 6703.4 6627.0 6664.8 6669.3 6685.5 6814.1 6401.4 6502.0 6517.0 6564.9 6566.4 06:02:39 INFO - PID 5785 | 06:02:39 INFO - PID 5785 | [#1] ext.html Cycles:180 Average:42845.29 Median:3749.66 stddev:65509.63 (1747.1%) stddev-sans-first:65617.34 06:02:39 INFO - PID 5785 | Values: 800.7 865.5 891.0 896.5 1227.2 31856.7 32646.3 41788.4 41914.8 42438.0 42524.0 43013.8 43021.8 43194.8 43215.1 7649.9 7976.4 8171.4 8173.2 8174.3 7976.6 8062.4 8072.3 8075.4 8085.6 8024.1 8095.4 8095.8 8099.2 8106.0 8059.8 8087.9 8096.2 8112.0 8115.6 7728.8 7749.2 7779.1 7810.3 7817.0 38479.8 38670.4 38710.8 38714.6 38719.6 3679.0 3747.6 3751.7 3751.8 3752.1 33062.2 33121.0 33172.5 33181.8 33221.7 5311.8 5373.7 5445.9 5462.7 5494.7 215292.0 216037.0 217070.9 217753.0 217938.0 52138.2 52326.5 52370.2 52394.0 52418.5 56477.7 57533.0 57615.7 57629.0 57640.1 15106.2 15379.4 16734.7 16741.7 16839.2 13583.4 13817.2 13833.4 13836.5 13845.4 15155.5 15227.0 15271.2 15279.0 15418.5 5572.5 5749.9 5868.4 5938.2 5965.9 1066.8 1090.0 1090.8 1092.4 1095.3 25809.6 25858.3 26143.3 26413.9 26456.9 1193.1 1200.5 1200.9 1202.6 1215.7 13423.5 13506.6 13554.7 13575.5 13771.7 288033.0 289692.0 290023.0 290361.0 291642.0 55358.7 55656.7 55699.4 55780.9 55831.4 1488.6 1495.8 1513.3 1522.1 1533.2 24837.3 24901.0 25067.1 25096.9 25403.7 39800.2 39803.0 39899.0 39947.2 39975.8 242641.0 243002.0 243040.0 243388.0 243884.0 34744.8 39130.0 39582.4 39618.2 39629.4 48039.5 48127.0 48225.0 49109.3 49399.3 36495.0 36709.4 36820.0 36976.8 37068.6 36737.6 36799.6 36860.4 37081.4 37114.0 41734.4 41779.6 41998.0 42276.2 42279.8 35013.5 35017.3 35101.8 35136.8 35517.3 25949.7 26268.6 26571.5 26803.9 27044.9 06:02:39 INFO - PID 5785 | 06:02:39 INFO - PID 5785 | [#2] jquery.html Cycles:180 Average:41127.86 Median:12369.80 stddev:106707.97 (862.6%) stddev-sans-first:106963.92 06:02:39 INFO - PID 5785 | Values: 599.2 601.0 601.3 606.3 615.9 22223.3 22695.9 22714.3 22988.9 23022.8 26530.2 26754.7 27119.2 27133.9 27206.0 6495.8 6687.3 6698.0 6698.9 6733.0 5909.1 6591.0 6596.1 6604.8 6606.6 6556.1 6569.9 6584.1 6597.1 6601.3 6543.9 6548.4 6555.1 6563.2 6563.7 6078.7 6087.7 6106.9 6142.8 6145.1 29749.3 30143.8 30660.2 30690.7 30904.4 2220.0 2250.7 2254.2 2261.3 2266.8 19693.2 19943.4 20879.9 20920.3 20966.0 2506.4 2519.0 2526.6 2538.5 2591.8 152433.0 152519.2 158052.0 158778.0 159189.0 15677.7 16008.5 16278.9 16335.3 16388.0 26402.7 26409.7 26420.6 26459.2 26495.9 10634.3 11044.6 11081.8 11091.8 11113.7 10017.1 10019.0 10096.8 10101.8 10220.8 9794.1 9831.4 9997.2 10012.4 10220.5 2884.6 2967.5 2969.3 2990.6 3017.1 1061.8 1066.2 1067.3 1069.5 1092.5 21641.7 21739.0 21869.9 21885.7 22028.0 1134.5 1136.6 1146.2 1158.8 1164.6 11669.6 14299.0 14337.4 14982.3 15220.7 631836.0 633821.0 636997.0 638428.0 651958.0 134027.0 134806.0 135115.0 136998.0 137296.3 1291.4 1297.9 1340.3 1342.9 1347.4 22239.6 22488.9 22671.0 22739.3 22921.8 61086.4 62665.0 62954.0 64061.0 64167.0 76579.2 77516.6 77572.0 78122.0 78171.6 15299.8 15514.1 15634.8 15726.4 15821.3 24539.9 24559.6 24804.6 24861.3 24862.6 19265.0 19760.5 19829.7 20235.9 20247.3 17168.9 17270.7 17350.9 17758.6 18066.6 19525.3 19757.4 19949.7 20003.8 20292.6 14684.9 15170.3 15314.8 15469.4 15525.0 19521.3 19618.7 19639.7 19767.8 19847.6 06:02:39 INFO - PID 5785 | 06:02:39 INFO - PID 5785 | [#3] mootools.html Cycles:180 Average:10407.28 Median:2828.43 stddev:7665.14 (271.0%) stddev-sans-first:7656.82 06:02:39 INFO - PID 5785 | Values: 1408.0 1452.9 1455.2 1456.5 1461.7 16241.8 16365.9 16998.3 17027.9 17046.5 17021.7 17309.6 17316.2 17321.0 17364.5 2887.7 2927.2 2927.5 2927.9 2930.5 2832.6 2911.0 2911.5 2912.0 2915.1 2824.8 2853.1 2855.8 2856.6 2858.5 2759.5 2829.0 2830.3 2835.3 2835.7 2798.3 2827.8 2835.7 2837.7 2839.4 16099.5 16189.7 16357.7 16372.8 16381.7 8482.4 8785.3 8801.3 8826.4 8853.8 5378.1 5526.3 5725.0 5751.3 5761.8 2067.5 2116.0 2141.1 2158.2 2173.4 29816.9 29906.0 29923.3 30044.1 30070.2 7151.0 7294.3 7360.9 7447.5 7530.4 19101.1 19138.0 19166.8 19181.4 19198.0 8285.5 8437.9 8442.9 8443.2 8449.1 6609.0 6855.3 7066.6 7992.8 8018.6 5457.9 5676.9 5700.1 5712.7 5812.1 1558.4 1559.2 1583.5 1594.6 1598.7 965.2 996.2 998.2 1000.5 1020.1 8596.7 8650.5 8653.3 8712.9 8771.3 767.1 768.6 769.6 774.1 774.9 5162.5 5886.2 6039.2 6046.2 6257.5 24185.0 25296.0 25440.0 25440.0 25453.0 23611.3 24493.0 24770.0 24892.4 24977.0 11949.0 11980.2 12246.8 12256.6 12270.8 9482.6 9510.5 9532.4 9551.0 9624.3 20853.0 20929.5 21018.3 21394.9 21563.5 21707.3 22154.2 22310.0 22415.3 22848.4 13496.2 13540.1 13668.5 13857.2 13861.2 15502.2 15634.1 15635.3 15643.1 15654.8 12569.2 12709.9 12794.7 12889.8 12899.9 11907.2 11973.4 12065.9 12141.2 12523.2 10701.2 10965.1 10996.9 11006.1 11012.1 8049.1 8203.8 8211.4 8238.7 8252.8 8094.5 8176.6 8213.7 8229.8 8282.3 06:02:39 INFO - PID 5785 | 06:02:39 INFO - PID 5785 | [#4] prototype.html Cycles:180 Average:5536.58 Median:6124.48 stddev:1540.91 (25.2%) stddev-sans-first:1499.04 06:02:39 INFO - PID 5785 | Values: 547.4 564.4 577.1 578.8 583.2 6091.4 6092.5 6110.7 6211.1 6224.5 6016.8 6072.0 6073.9 6138.3 6151.8 5040.9 5045.2 5052.9 5059.4 5077.7 4835.5 4904.5 4957.6 4972.3 5028.6 4773.2 4814.8 4844.3 4863.5 4897.1 4838.7 4851.7 4881.4 4901.7 4906.5 4360.2 4414.8 4421.8 4432.8 4462.0 5905.1 5926.8 5994.7 6006.3 6021.3 5660.2 5723.5 5726.1 5730.3 5786.6 6540.5 6558.0 6570.3 6594.3 6594.6 4916.9 4941.3 4961.2 4979.8 4988.6 6623.8 6710.0 6737.9 6824.1 6878.5 4948.5 5065.0 5090.9 5127.0 5130.6 5177.8 5184.6 5203.5 5210.6 5234.3 5742.1 5751.3 5782.6 5786.1 5800.2 6609.1 6650.5 6653.4 6664.6 6664.8 1807.6 1811.4 1814.4 1836.3 1838.7 1248.0 1280.4 1292.8 1295.6 1295.7 6141.8 6150.4 6187.5 6199.4 6208.6 6376.3 6674.4 6695.1 6709.2 6750.4 5934.5 5945.5 6059.8 6060.4 6100.2 3482.5 3508.1 3516.3 3519.6 3523.7 6891.8 6906.0 6922.7 6936.4 6967.3 6753.8 6776.3 6840.6 6843.9 6879.6 6925.1 6943.7 6949.4 6970.8 6971.8 6443.2 6588.4 6598.9 6608.9 6621.0 6415.4 6416.3 6471.6 6524.5 6585.0 6846.2 6870.2 6911.9 6971.7 7014.3 5130.0 5140.7 5145.2 5151.1 5172.4 6360.2 6540.7 6633.0 6671.9 6728.9 6300.5 6334.4 6338.1 6361.4 6386.5 6320.3 6353.5 6380.5 6403.8 6413.2 6266.7 6373.6 6378.8 6417.0 6435.5 6412.3 6462.5 6462.6 6473.6 6477.2 6215.3 6273.0 6300.7 6324.8 6362.5 06:02:39 INFO - PID 5785 | 06:02:39 INFO - PID 5785 | [#5] yui.html Cycles:180 Average:26772.39 Median:20615.54 stddev:36790.82 (178.5%) stddev-sans-first:36842.95 06:02:39 INFO - PID 5785 | Values: 954.4 959.8 975.8 979.0 992.5 20314.5 20460.6 20778.2 20859.6 21401.5 22228.0 22508.9 22643.5 22644.9 22690.3 1013.0 1051.6 1052.2 1052.5 1053.6 1076.8 1123.4 1124.1 1124.3 1125.5 1159.6 1162.9 1163.0 1163.2 1166.2 1155.8 1156.5 1158.1 1158.7 1164.1 853.3 853.7 853.9 855.0 859.4 19304.6 19620.5 19684.4 20567.3 21288.4 23145.2 23212.2 23249.9 23423.3 23724.4 17384.4 17632.9 17685.7 17929.0 18034.9 4020.3 4059.9 4060.4 4061.4 4063.1 141660.0 142722.0 144735.0 146399.0 146588.3 17321.7 17440.7 17549.1 17720.6 17728.2 33517.3 34086.8 34486.8 34526.5 34600.5 9026.8 9119.3 9148.3 9151.9 9160.7 4109.9 4802.0 4823.2 4841.6 4842.3 6377.2 6573.9 6649.0 6680.8 6689.3 1158.7 1216.6 1232.6 1240.4 1244.8 677.7 692.4 709.3 715.9 739.8 12708.6 14346.7 14456.6 15151.2 15695.8 637.4 700.6 735.0 740.7 758.2 6266.4 6636.8 6689.2 6900.7 6927.6 126167.0 127232.0 129031.4 132705.0 133156.0 104852.0 110675.0 112070.0 112967.4 114963.0 99854.0 100272.5 101340.5 101923.5 105914.0 13919.7 14136.4 14176.0 14262.5 14298.5 49997.0 50443.7 50883.5 50909.5 51362.0 64205.0 64683.4 65149.7 66535.0 66590.3 18809.8 20069.3 20663.8 20799.5 20863.8 22454.3 22575.2 22608.2 22705.9 22722.4 19682.6 19951.7 21769.8 22032.1 22085.9 19488.4 19726.4 19776.4 19811.5 19846.9 20270.0 20378.8 20949.5 20974.3 21009.1 14627.2 14762.7 14954.8 15132.0 15703.1 15791.7 16109.1 16308.3 16322.6 16336.3 06:02:39 INFO - PID 5785 | -------- Summary: end -------- 06:02:39 INFO - PID 5785 | 06:02:40 INFO - TEST-INFO | 5785: exit 0 06:02:40 INFO - TEST-OK | dromaeo_css | took 1107598ms 06:02:40 INFO - TEST-START | kraken 06:02:40 INFO - Initialising browser for kraken test... 06:02:40 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:57477/getInfo.html -profile /tmp/tmpF6aUP2/profile 06:02:40 INFO - TEST-INFO | started process 6170 (/builds/slave/test/build/application/firefox/firefox http://localhost:57477/getInfo.html) 06:02:45 INFO - TEST-INFO | 6170: exit 0 06:02:45 INFO - Browser initialized. 06:02:45 INFO - Running cycle 1/1 for kraken test... 06:02:45 INFO - Using env: {'DISPLAY': ':0', 06:02:45 INFO - 'HOME': '/home/cltbld', 06:02:45 INFO - 'JSGC_DISABLE_POISONING': '1', 06:02:45 INFO - 'LANG': 'en_US.UTF-8', 06:02:45 INFO - 'LANGUAGE': 'en_US:en', 06:02:45 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 06:02:45 INFO - 'LOGNAME': 'cltbld', 06:02:45 INFO - 'MAIL': '/var/mail/cltbld', 06:02:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:02:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:02:45 INFO - 'MOZ_CRASHREPORTER': '1', 06:02:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:02:45 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 06:02:45 INFO - 'MOZ_NO_REMOTE': '1', 06:02:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:02:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:02:45 INFO - 'NO_EM_RESTART': '1', 06:02:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:02:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:02:45 INFO - 'PWD': '/builds/slave/test', 06:02:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:02:45 INFO - 'RUST_BACKTRACE': 'full', 06:02:45 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 06:02:45 INFO - 'SHELL': '/bin/bash', 06:02:45 INFO - 'SHLVL': '1', 06:02:45 INFO - 'STYLO_FORCE_DISABLED': '1', 06:02:45 INFO - 'TERM': 'linux', 06:02:45 INFO - 'TMOUT': '86400', 06:02:45 INFO - 'USER': 'cltbld', 06:02:45 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1504788184.137758-2072291508', 06:02:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:02:45 INFO - '_': '/tools/buildbot/bin/python'} 06:02:45 INFO - TEST-INFO | started process 6366 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpF6aUP2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 06:02:46 INFO - PID 6366 | 06:02:46 INFO - PID 6366 | (/builds/slave/test/build/application/firefox/firefox:6416): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 06:02:46 INFO - PID 6366 | 06:02:56 INFO - PID 6366 | RSS: Main: 161976320 06:02:56 INFO - PID 6366 | 06:02:59 INFO - PID 6366 | Cycle 1(1): loaded http://localhost:57477/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57477/tests/kraken/driver.html?testName=audio-beat-detection) 06:02:59 INFO - PID 6366 | RSS: Main: 168919040 06:02:59 INFO - PID 6366 | 06:03:02 INFO - PID 6366 | Cycle 1(1): loaded http://localhost:57477/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57477/tests/kraken/driver.html?testName=audio-dft) 06:03:03 INFO - PID 6366 | RSS: Main: 169107456 06:03:03 INFO - PID 6366 | 06:03:06 INFO - PID 6366 | Cycle 1(1): loaded http://localhost:57477/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57477/tests/kraken/driver.html?testName=audio-fft) 06:03:06 INFO - PID 6366 | RSS: Main: 162881536 06:03:06 INFO - PID 6366 | 06:03:08 INFO - PID 6366 | Cycle 1(1): loaded http://localhost:57477/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57477/tests/kraken/driver.html?testName=audio-oscillator) 06:03:09 INFO - PID 6366 | RSS: Main: 164409344 06:03:09 INFO - PID 6366 | 06:03:11 INFO - PID 6366 | Cycle 1(1): loaded http://localhost:57477/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57477/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:03:12 INFO - PID 6366 | RSS: Main: 164372480 06:03:12 INFO - PID 6366 | 06:03:15 INFO - PID 6366 | Cycle 1(1): loaded http://localhost:57477/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57477/tests/kraken/driver.html?testName=imaging-darkroom) 06:03:15 INFO - PID 6366 | RSS: Main: 164745216 06:03:15 INFO - PID 6366 | 06:03:19 INFO - PID 6366 | Cycle 1(1): loaded http://localhost:57477/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57477/tests/kraken/driver.html?testName=imaging-desaturate) 06:03:19 INFO - PID 6366 | RSS: Main: 167378944 06:03:19 INFO - PID 6366 | 06:03:22 INFO - PID 6366 | Cycle 1(1): loaded http://localhost:57477/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57477/tests/kraken/driver.html?testName=json-parse-financial) 06:03:23 INFO - PID 6366 | RSS: Main: 167616512 06:03:23 INFO - PID 6366 | 06:03:24 INFO - PID 6366 | Cycle 1(1): loaded http://localhost:57477/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57477/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:03:25 INFO - PID 6366 | RSS: Main: 167313408 06:03:25 INFO - PID 6366 | 06:03:26 INFO - PID 6366 | Cycle 1(1): loaded http://localhost:57477/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57477/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:03:27 INFO - PID 6366 | RSS: Main: 167550976 06:03:27 INFO - PID 6366 | 06:03:29 INFO - PID 6366 | Cycle 1(1): loaded http://localhost:57477/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57477/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:03:30 INFO - PID 6366 | RSS: Main: 164392960 06:03:30 INFO - PID 6366 | 06:03:32 INFO - PID 6366 | Cycle 1(1): loaded http://localhost:57477/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57477/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:03:33 INFO - PID 6366 | RSS: Main: 164327424 06:03:33 INFO - PID 6366 | 06:03:36 INFO - PID 6366 | Cycle 1(1): loaded http://localhost:57477/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57477/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:03:36 INFO - PID 6366 | RSS: Main: 164921344 06:03:36 INFO - PID 6366 | 06:03:38 INFO - PID 6366 | Cycle 1(1): loaded http://localhost:57477/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57477/tests/kraken/driver.html?testName=ai-astar) 06:03:38 INFO - PID 6366 | RSS: Main: 166883328 06:03:38 INFO - PID 6366 | 06:03:38 INFO - PID 6366 | __start_tp_report 06:03:38 INFO - PID 6366 | _x_x_mozilla_page_load 06:03:38 INFO - PID 6366 | _x_x_mozilla_page_load_details 06:03:38 INFO - PID 6366 | |i|pagename|runs| 06:03:38 INFO - PID 6366 | |0;ai-astar;97;105;99;106;105;105;114;97;104;109 06:03:38 INFO - PID 6366 | |1;audio-beat-detection;144;112;137;166;119;141;141;112;160;114 06:03:38 INFO - PID 6366 | |2;audio-dft;163;162;162;163;162;161;163;160;163;167 06:03:38 INFO - PID 6366 | |3;audio-fft;75;74;73;184;73;73;73;75;167;74 06:03:38 INFO - PID 6366 | |4;audio-oscillator;77;78;130;78;78;78;132;77;82;133 06:03:38 INFO - PID 6366 | |5;imaging-gaussian-blur;115;114;114;114;114;114;114;114;114;115 06:03:38 INFO - PID 6366 | |6;imaging-darkroom;151;149;149;149;150;150;149;149;151;151 06:03:38 INFO - PID 6366 | |7;imaging-desaturate;94;95;94;94;93;94;94;94;93;93 06:03:38 INFO - PID 6366 | |8;json-parse-financial;43;48;55;44;44;45;43;44;43;45 06:03:38 INFO - PID 6366 | |9;json-stringify-tinderbox;38;37;38;37;37;37;37;38;38;37 06:03:38 INFO - PID 6366 | |10;stanford-crypto-aes;71;73;73;71;72;75;72;72;72;73 06:03:38 INFO - PID 6366 | |11;stanford-crypto-ccm;112;110;110;115;127;108;110;117;119;145 06:03:38 INFO - PID 6366 | |12;stanford-crypto-pbkdf2;158;155;154;163;163;153;151;152;152;162 06:03:38 INFO - PID 6366 | |13;stanford-crypto-sha256-iterative;60;58;60;59;59;59;62;58;59;57 06:03:38 INFO - PID 6366 | __end_tp_report 06:03:38 INFO - PID 6366 | __start_cc_report 06:03:38 INFO - PID 6366 | _x_x_mozilla_cycle_collect,897 06:03:38 INFO - PID 6366 | __end_cc_report 06:03:38 INFO - PID 6366 | __startTimestamp1504789418549__endTimestamp 06:03:38 INFO - PID 6366 | 06:03:38 INFO - PID 6366 | ------- Summary: start ------- 06:03:38 INFO - PID 6366 | Number of tests: 14 06:03:38 INFO - PID 6366 | 06:03:38 INFO - PID 6366 | [#0] ai-astar Cycles:10 Average:104.10 Median:111.50 stddev:5.32 (4.8%) stddev-sans-first:4.99 06:03:38 INFO - PID 6366 | Values: 97.0 105.0 99.0 106.0 105.0 105.0 114.0 97.0 104.0 109.0 06:03:38 INFO - PID 6366 | 06:03:38 INFO - PID 6366 | [#1] audio-beat-detection Cycles:10 Average:134.60 Median:141.00 stddev:19.71 (14.0%) stddev-sans-first:20.61 06:03:38 INFO - PID 6366 | Values: 144.0 112.0 137.0 166.0 119.0 141.0 141.0 112.0 160.0 114.0 06:03:38 INFO - PID 6366 | 06:03:38 INFO - PID 6366 | [#2] audio-dft Cycles:10 Average:162.60 Median:163.00 stddev:1.84 (1.1%) stddev-sans-first:1.94 06:03:38 INFO - PID 6366 | Values: 163.0 162.0 162.0 163.0 162.0 161.0 163.0 160.0 163.0 167.0 06:03:38 INFO - PID 6366 | 06:03:38 INFO - PID 6366 | [#3] audio-fft Cycles:10 Average:94.10 Median:73.50 stddev:43.10 (58.6%) stddev-sans-first:45.15 06:03:38 INFO - PID 6366 | Values: 75.0 74.0 73.0 184.0 73.0 73.0 73.0 75.0 167.0 74.0 06:03:38 INFO - PID 6366 | 06:03:38 INFO - PID 6366 | [#4] audio-oscillator Cycles:10 Average:94.30 Median:78.00 stddev:25.83 (33.1%) stddev-sans-first:26.63 06:03:38 INFO - PID 6366 | Values: 77.0 78.0 130.0 78.0 78.0 78.0 132.0 77.0 82.0 133.0 06:03:38 INFO - PID 6366 | 06:03:38 INFO - PID 6366 | [#5] imaging-gaussian-blur Cycles:10 Average:114.20 Median:114.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 06:03:38 INFO - PID 6366 | Values: 115.0 114.0 114.0 114.0 114.0 114.0 114.0 114.0 114.0 115.0 06:03:38 INFO - PID 6366 | 06:03:38 INFO - PID 6366 | [#6] imaging-darkroom Cycles:10 Average:149.80 Median:150.00 stddev:0.92 (0.6%) stddev-sans-first:0.87 06:03:38 INFO - PID 6366 | Values: 151.0 149.0 149.0 149.0 150.0 150.0 149.0 149.0 151.0 151.0 06:03:38 INFO - PID 6366 | 06:03:38 INFO - PID 6366 | [#7] imaging-desaturate Cycles:10 Average:93.80 Median:94.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 06:03:38 INFO - PID 6366 | Values: 94.0 95.0 94.0 94.0 93.0 94.0 94.0 94.0 93.0 93.0 06:03:38 INFO - PID 6366 | 06:03:38 INFO - PID 6366 | [#8] json-parse-financial Cycles:10 Average:45.40 Median:44.50 stddev:3.69 (8.3%) stddev-sans-first:3.81 06:03:38 INFO - PID 6366 | Values: 43.0 48.0 55.0 44.0 44.0 45.0 43.0 44.0 43.0 45.0 06:03:38 INFO - PID 6366 | 06:03:38 INFO - PID 6366 | [#9] json-stringify-tinderbox Cycles:10 Average:37.40 Median:37.50 stddev:0.52 (1.4%) stddev-sans-first:0.50 06:03:38 INFO - PID 6366 | Values: 38.0 37.0 38.0 37.0 37.0 37.0 37.0 38.0 38.0 37.0 06:03:38 INFO - PID 6366 | 06:03:38 INFO - PID 6366 | [#10] stanford-crypto-aes Cycles:10 Average:72.40 Median:72.50 stddev:1.17 (1.6%) stddev-sans-first:1.13 06:03:38 INFO - PID 6366 | Values: 71.0 73.0 73.0 71.0 72.0 75.0 72.0 72.0 72.0 73.0 06:03:38 INFO - PID 6366 | 06:03:38 INFO - PID 6366 | [#11] stanford-crypto-ccm Cycles:10 Average:117.30 Median:116.00 stddev:11.27 (9.7%) stddev-sans-first:11.79 06:03:38 INFO - PID 6366 | Values: 112.0 110.0 110.0 115.0 127.0 108.0 110.0 117.0 119.0 145.0 06:03:38 INFO - PID 6366 | 06:03:38 INFO - PID 6366 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.30 Median:156.50 stddev:4.81 (3.1%) stddev-sans-first:5.06 06:03:38 INFO - PID 6366 | Values: 158.0 155.0 154.0 163.0 163.0 153.0 151.0 152.0 152.0 162.0 06:03:38 INFO - PID 6366 | 06:03:38 INFO - PID 6366 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:59.10 Median:59.00 stddev:1.37 (2.3%) stddev-sans-first:1.41 06:03:38 INFO - PID 6366 | Values: 60.0 58.0 60.0 59.0 59.0 59.0 62.0 58.0 59.0 57.0 06:03:38 INFO - PID 6366 | -------- Summary: end -------- 06:03:38 INFO - PID 6366 | 06:03:38 INFO - PID 6366 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 06:03:39 INFO - TEST-INFO | 6366: exit 0 06:03:39 INFO - TEST-OK | kraken | took 58847ms 06:03:39 INFO - SUITE-END | took 1166s 06:03:39 INFO - Completed test suite (00:19:26) 06:03:39 INFO - javascript benchmark 06:03:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9113.192049078829, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3843.3850583906565, 3864.323743344915, 3886.8445262189507, 3911.29596672599, 3912.8826135215954, 6357.110004599348, 6369.968150159249, 6419.839504012396, 6424.325445828191, 6435.742570297189, 6234.0648902664625, 6336.239651241846, 6342.714577843996, 6352.491800655948, 6378.298387177419, 5682.431756824305, 5705.343885453164, 5709.143628455734, 5715.485606295432, 5737.311522617292, 5731.512821410185, 5754.079347304432, 5767.106098554731, 5768.105943578752, 5787.0, 5723.742431590567, 5751.079827227644, 5770.624909380897, 5780.595358324919, 5787.681677507735, 5669.348024977139, 5807.941920580783, 5816.534677225812, 5826.708664566797, 5830.446107619811, 5637.915431268534, 5712.22884910536, 5726.713664316809, 5741.425857414267, 5741.741621627037, 5830.300363956352, 6213.5961162524745, 6269.153664255358, 6285.465735412496, 6331.8733625327695, 6901.516893817435, 6912.619805910673, 6916.515843890929, 6928.61892595907, 6944.305569443066, 6929.618870962095, 7009.894851577231, 7010.193827709828, 7014.403775679073, 7026.086608740831, 6371.617702937839, 6372.776952806676, 6389.9680501597195, 6471.935280647181, 6481.384268494486, 6994.8950765738555, 7083.18543367509, 7091.184513780878, 7095.929040709527, 7101.183363913216, 6780.525363224527, 6821.590704557643, 6822.044913711985, 6852.554583952027, 6868.828279292958, 6873.793786186422, 6880.8967865482055, 6883.242843287235, 6968.860622787516, 6969.30306969299, 6827.0783444235385, 6831.2144103427745, 6911.516193866381, 6913.308669133046, 6925.688344024531, 6782.93217067823, 6829.658517074126, 6848.075509806212, 6880.931190688129, 6910.896336554955, 4995.150824359867, 5025.497450254945, 5057.418396884332, 5071.061853557104, 5084.161113416245, 4540.318952157137, 4574.794134263966, 4576.725396476222, 4590.839320623762, 4598.195315819718, 6264.0, 6285.59143655661, 6294.307626161119, 6352.237731472253, 6396.200474940632, 6799.422049125781, 6838.692258848364, 6838.974153876959, 6844.0, 6850.143732033496, 6326.652034138075, 6337.2395312562785, 6338.271098823602, 6338.524610654219, 6354.26925903527, 5464.836054918359, 5560.527355174855, 5582.413846546136, 5599.384067752544, 5604.327480702342, 7166.04306563915, 7171.784846454615, 7260.528065675714, 7263.818404539823, 7275.345218930322, 6725.058491811248, 6749.0, 6799.660016999229, 6805.2173999989645, 6888.517803753789, 7090.361867431956, 7172.390346820579, 7187.389071928736, 7191.568505889663, 7193.2087470379265, 6753.358430949052, 6823.93176068233, 6827.692753825991, 6838.658067096526, 6843.349881761224, 6785.898211526733, 6806.523543352116, 6868.896966545406, 6886.070380498769, 6983.301669832976, 6460.580062296123, 6553.836154096186, 6574.3754343337305, 6634.734610615521, 6652.73389064432, 6644.202695676549, 6696.1629796275465, 6702.0, 6706.932930670826, 6711.194656641234, 6533.509986751108, 6613.603183808987, 6628.76799312041, 6634.83412914681, 6703.363180497845, 6626.97281921303, 6664.83337916556, 6669.333066693486, 6685.465162787063, 6814.1482314710665, 6401.391867772554, 6501.9674901625185, 6517.022446633043, 6564.901526477202, 6566.376194261537], "value": 6283.998944758131, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [800.6877317846038, 865.5066612031142, 891.0198781340524, 896.5024411451645, 1227.2145826670937, 31856.681433185662, 32646.347073058554, 41788.37317440237, 41914.790426047904, 42438.0, 42524.0, 43013.78493107538, 43021.78489107558, 43194.784026079826, 43215.13569728604, 7649.92350076499, 7976.361891048731, 8171.387145964047, 8173.182681731839, 8174.26431621154, 7976.641051152712, 8062.395320350997, 8072.3138533224455, 8075.434719569633, 8085.636146373427, 8024.077231118408, 8095.392845536609, 8095.757127286191, 8099.230573095576, 8105.959470202641, 8059.838803223932, 8087.878681819778, 8096.190380961915, 8111.959440202821, 8115.594220288962, 7728.845423091563, 7749.225077492262, 7779.066512018594, 7810.258025487569, 7816.960915195445, 38479.80760096209, 38670.419943700865, 38710.80644596759, 38714.61285387138, 38719.61280387188, 3678.9632103678887, 3747.625237476258, 3751.6998640109, 3751.756135851161, 3752.061984503874, 33062.17344566381, 33121.0, 33172.50241246383, 33181.83409082963, 33221.6677833221, 5311.814086506954, 5373.6775793452125, 5445.945540544623, 5462.6995515247045, 5494.670319780826, 215292.0, 216037.0, 217070.91464542734, 217753.0, 217938.0, 52138.21792673113, 52326.47673523292, 52370.21444678333, 52394.0, 52418.47581524212, 56477.71761141168, 57533.0, 57615.71192144096, 57629.0, 57640.13539796906, 15106.169160696047, 15379.384824607114, 16734.66530669404, 16741.6651666966, 16839.158042097846, 13583.388747506386, 13817.170969741848, 13833.377498012613, 13836.515721949885, 13845.376958036912, 15155.469558565397, 15227.0, 15271.236438178268, 15279.0, 15418.460353887784, 5572.498475137257, 5749.85625359361, 5868.383819698955, 5938.168656388109, 5965.926133296049, 1066.7866426714534, 1089.9782004359868, 1090.820014697566, 1092.3991804507489, 1095.2880627592128, 25809.61285580718, 25858.319867536622, 26143.346416339362, 26413.867930660606, 26456.867715661298, 1193.146899966528, 1200.543793358518, 1200.9219400738923, 1202.5670758526924, 1215.671768622467, 13423.530176443777, 13506.59480215595, 13554.728905421836, 13575.524856630169, 13771.655708607164, 288033.0, 289692.0, 290023.0, 290361.0, 291642.0, 55358.723206384515, 55656.721716391155, 55699.443005569425, 55780.88438231213, 55831.44168558263, 1488.642725745813, 1495.7532007218904, 1513.3265696765054, 1522.079142119002, 1533.2333833083458, 24837.339463295477, 24901.0, 25067.093130762743, 25096.874515627303, 25403.74596254014, 39800.2039959205, 39803.0, 39899.0, 39947.201055978134, 39975.80012099921, 242641.0, 243002.0, 243040.0, 243388.0, 243884.0, 34744.82627586846, 39130.0, 39582.40626390549, 39618.20763584654, 39629.40555891721, 48039.51960480351, 48127.0, 48225.0, 49109.2633610489, 49399.25901111558, 36495.0, 36709.44935825912, 36820.0, 36976.81511592425, 37068.629313706515, 36737.632623673424, 36799.632003680694, 36860.447093293085, 37081.44377834281, 37114.0, 41734.37398439086, 41779.58220417878, 41998.0, 42276.15447690967, 42279.788601056796, 35013.47479787754, 35017.299654007285, 35101.824490877385, 35136.82431587826, 35517.28965420625, 25949.740502594734, 26268.60597091007, 26571.468570628094, 26803.927842886067, 27044.864775675996], "value": 18557.409717251987, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [599.1641659884461, 600.9681158555092, 601.3145014683262, 606.3239487970914, 615.8829822333756, 22223.333300000984, 22695.886520567416, 22714.318570442912, 22988.88505557472, 23022.769772302272, 26530.204093877215, 26754.732452675467, 27119.1864244073, 27133.86433067832, 27206.0, 6495.837604059889, 6687.264400915896, 6698.0, 6698.8995165072565, 6733.0, 5909.084091965752, 6590.967045164767, 6596.076549283104, 6604.834879128036, 6606.6036037837885, 6556.08214849919, 6569.934300657004, 6584.144061272052, 6597.142371491724, 6601.306862779411, 6543.93456065438, 6548.377904099103, 6555.082288479617, 6563.245226798931, 6563.704633291513, 6078.665673387962, 6087.665178415185, 6106.938930610726, 6142.754289828402, 6145.139680444741, 29749.256268593243, 30143.849280753675, 30660.2334941626, 30690.693093069007, 30904.381912361852, 2219.9889000554895, 2250.718660167479, 2254.211026140854, 2261.2537862505333, 2266.7733226677365, 19693.21227150912, 19943.401697949084, 20879.895600522053, 20920.267790627408, 20966.0, 2506.448581312127, 2518.987405062963, 2526.621006848969, 2538.4669219463935, 2591.753783390575, 152433.0, 152519.23740381337, 158052.0, 158778.0, 159189.0, 15677.686446271238, 16008.519744407686, 16278.918605407134, 16335.346586136659, 16388.0, 26402.73597264003, 26409.73590264111, 26420.603690944652, 26459.206223813315, 26495.867520662272, 10634.308769930085, 11044.613438529774, 11081.833772493419, 11091.778164436666, 11113.722156946142, 10017.098461138532, 10019.0, 10096.848547271797, 10101.797964040677, 10220.795584088277, 9794.118529332394, 9831.360961537477, 9997.200223982063, 10012.39925604466, 10220.540075696463, 2884.5528943013865, 2967.5251959686348, 2969.346743716422, 2990.551417287424, 3017.109952563999, 1061.8460323253084, 1066.226985435553, 1067.3062509368972, 1069.5240617924949, 1092.4537731134433, 21641.675374869388, 21739.0, 21869.890650546644, 21885.67171492429, 22028.008739606757, 1134.4838098665089, 1136.5681041204455, 1146.1747541769912, 1158.8493495845487, 1164.63896192179, 11669.591564295379, 14299.0, 14337.426502939765, 14982.250887455584, 15220.695586088215, 631836.0, 633821.0, 636997.0, 638428.0, 651958.0, 134027.0, 134806.0, 135115.0, 136998.0, 137296.31351843377, 1291.4188615123232, 1297.8961683065331, 1340.2963444191878, 1342.8657134286689, 1347.3532704302186, 22239.555208896054, 22488.887555562116, 22671.0, 22739.317820465414, 22921.77078229263, 61086.38913610807, 62665.0, 62954.0, 64061.0, 64167.0, 76579.23420765721, 77516.61241693755, 77572.0, 78122.0, 78171.6091419562, 15299.847001530288, 15514.14672192995, 15634.843651563338, 15726.370945162065, 15821.288042038366, 24539.87730061338, 24559.63160552629, 24804.627930580697, 24861.254162375157, 24862.627060593742, 19265.0, 19760.505987350432, 19829.702554461983, 20235.898820505805, 20247.29134480286, 17168.914155429644, 17270.654586908444, 17350.91324543369, 17758.644827103126, 18066.638667226845, 19525.316613918443, 19757.407277781116, 19949.700754488404, 20003.799962000194, 20292.59414811725, 14684.926575367055, 15170.31733572014, 15314.770278446054, 15469.381224750883, 15525.0, 19521.316753913547, 19618.705719414505, 19639.70540441923, 19767.802321976596, 19847.60304793867], "value": 12999.738783818064, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1407.9507217247394, 1452.941882324707, 1455.2141843404556, 1456.4829485532637, 1461.729580027695, 16241.756373654405, 16365.918170409146, 16998.320067197314, 17027.91486042571, 17046.488605341827, 17021.744673829904, 17309.567260818487, 17316.220770065345, 17321.0, 17364.479065628053, 2887.653481582213, 2927.19502136913, 2927.531594944809, 2927.88288468461, 2930.4578652949167, 2832.5978640572944, 2911.0, 2911.5487099499505, 2911.985440072797, 2915.11089117819, 2824.8305101693863, 2853.1012730989773, 2855.771538276933, 2856.6143570618015, 2858.5283428234316, 2759.4894944435346, 2829.038127036807, 2830.3207230264793, 2835.2911772056987, 2835.673897501793, 2798.3423895384567, 2827.816191947517, 2835.6597208334924, 2837.702041285656, 2839.3895312507702, 16099.517014489584, 16189.676206475922, 16357.672846543002, 16372.83627163725, 16381.672366552602, 8482.363822713321, 8785.341099417505, 8801.251893589053, 8826.382153249275, 8853.822923541558, 5378.085725426687, 5526.336839579236, 5725.0, 5751.332113687067, 5761.769529218826, 2067.5348046689373, 2115.982016137837, 2141.0793358855685, 2158.2230397057047, 2173.3914503938922, 29816.8509157455, 29906.0, 29923.251918702208, 30044.098677039507, 30070.24824379386, 7151.0, 7294.343509084208, 7360.852782944311, 7447.515911465737, 7530.359919406802, 19101.140448679842, 19138.0, 19166.80833191678, 19181.424557263304, 19198.0, 8285.50286982783, 8437.915620843713, 8442.873356899652, 8443.197896199852, 8449.112843151504, 6609.0, 6855.348741869514, 7066.646667666596, 7992.760217193493, 8018.639161237758, 5457.918131228034, 5676.914846277309, 5700.059490184156, 5712.742926568314, 5812.070068789058, 1558.3688606114542, 1559.2125976381853, 1583.5407731757891, 1594.6332343560814, 1598.7042397156563, 965.232640051161, 996.1632228927591, 998.2313618513704, 1000.5047501486665, 1020.1481762728205, 8596.699115530926, 8650.52422116777, 8653.307735381155, 8712.869306960401, 8771.254443372385, 767.098659075584, 768.5772824946257, 769.6459628570808, 774.0865778381564, 774.9151188336261, 5162.502874166525, 5886.234789477427, 6039.245094363205, 6046.244219472566, 6257.4681152102585, 24185.0, 25296.0, 25440.0, 25440.0, 25453.0, 23611.29166125019, 24493.0, 24770.0, 24892.377690557518, 24977.0, 11949.0, 11980.22128561658, 12246.81629775554, 12256.632301030982, 12270.81593776094, 9482.620695172393, 9510.47692376926, 9532.428054316762, 9551.0, 9624.326297159132, 20853.0, 20929.476763081046, 21018.2643607473, 21394.893025534773, 21563.46091347666, 21707.348779536638, 22154.22460213885, 22310.0, 22415.32754017382, 22848.428789279737, 13496.190228586316, 13540.119892206974, 13668.52160174389, 13857.237851918242, 13861.168329900238, 15502.224888755743, 15634.140122293384, 15635.29641166173, 15643.061416314602, 15654.843451565794, 12569.245845249314, 12709.936450318059, 12794.68013299675, 12889.8066529004, 12899.871001289866, 11907.226030308002, 11973.401329933642, 12065.879341206475, 12141.150119491904, 12523.248605083723, 10701.197410194422, 10965.067969222386, 10996.945015274872, 11006.119510439306, 11012.119030477703, 8049.072411729457, 8203.753887383387, 8211.425200235926, 8238.670453181805, 8252.752417427488, 8094.51432914027, 8176.550289733884, 8213.671453142046, 8229.835403291781, 8282.254597086292], "value": 7268.299875876178, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [547.4142667345941, 564.4045531963776, 577.1256546332307, 578.8263520943716, 583.1573376470999, 6091.421314975081, 6092.451679348857, 6110.663913484756, 6211.130441738149, 6224.470919971802, 6016.75932962681, 6072.0, 6073.904502946476, 6138.294096178941, 6151.81544553663, 5040.916203016351, 5045.217991211368, 5052.873678158038, 5059.443461219263, 5077.669951453162, 4835.492273311304, 4904.460509343987, 4957.603391728671, 4972.25416187573, 5028.597712183035, 4773.212419950704, 4814.7833347499445, 4844.297576851354, 4863.537963893425, 4897.118518666639, 4838.685485443452, 4851.738547977516, 4881.365422495053, 4901.705897646153, 4906.484819094015, 4360.21516127097, 4414.84548040817, 4421.778911054466, 4432.84485043022, 4462.0, 5905.106497816082, 5926.844265368255, 5994.700264986734, 6006.279246490449, 6021.307549631804, 5660.179274005287, 5723.484886360206, 5726.141078838166, 5730.34101078373, 5786.553361659585, 6540.509461790337, 6558.0, 6570.277269500351, 6594.274629790719, 6594.604323740591, 4916.926246106311, 4941.308216849644, 4961.206207006898, 4979.775910084055, 4988.625853061035, 6623.834404139935, 6709.966450167718, 6737.898931516032, 6824.1469816272465, 6878.457594338919, 4948.455669876311, 5064.974675126601, 5090.872728181751, 5127.0, 5130.589552835764, 5177.792888284502, 5184.585233181337, 5203.453637368098, 5210.609204309692, 5234.293370395024, 5742.13867919807, 5751.281089863767, 5782.624129431573, 5786.103154011135, 5800.187973683687, 6609.1408116944485, 6650.53446258767, 6653.434458071021, 6664.566803157876, 6664.800335939577, 1807.5842556212144, 1811.4203454894307, 1814.4193857965324, 1836.3389179895228, 1838.6874231380698, 1247.9500819967282, 1280.4494067550856, 1292.8190053392532, 1295.5724610878387, 1295.7214198947272, 6141.7543298268465, 6150.354212807591, 6187.504999600022, 6199.442050215503, 6208.627482351073, 6376.266729326187, 6674.399304062561, 6695.12963314766, 6709.194896612437, 6750.426213771786, 5934.465898069108, 5945.464908158287, 6059.8485037873525, 6060.363661815534, 6100.206973093469, 3482.46021866606, 3508.1054331145906, 3516.3318969396246, 3519.59524654668, 3523.665251801126, 6891.758788442481, 6905.964105384132, 6922.653867306614, 6936.375726184668, 6967.342145373719, 6753.750556147129, 6776.2546119926765, 6840.555363901331, 6843.863122737617, 6879.58722476653, 6925.065116209247, 6943.72225111, 6949.409300209438, 6970.849809781431, 6971.82570435733, 6443.194600674916, 6588.37410446026, 6598.934010659832, 6608.867822643617, 6620.966895165493, 6415.390537898892, 6416.299680584742, 6471.579347342407, 6524.510661700487, 6585.012248162814, 6846.178458585002, 6870.213744426385, 6911.89632155508, 6971.6862741175755, 7014.2635023323855, 5130.0, 5140.73807524688, 5145.151050076845, 5151.124308867426, 5172.379314482136, 6360.236771587439, 6540.705668245036, 6633.0, 6671.866562668816, 6728.8654226914205, 6300.495960323072, 6334.429901308904, 6338.11266422692, 6361.395667411589, 6386.517684550093, 6320.304766475592, 6353.459955903615, 6380.500582363234, 6403.807885763435, 6413.16628838248, 6266.717997690206, 6373.553851230555, 6378.77674281398, 6417.005364168562, 6435.517336199898, 6412.294647588668, 6462.515311351762, 6462.612243265419, 6473.640535487412, 6477.222733272038, 6215.254169499689, 6273.0, 6300.7479700811455, 6324.778632747832, 6362.459190968634], "value": 5099.3301824024675, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [954.4130359828707, 959.7888464537801, 975.790205105902, 978.9853152202722, 992.4938281476448, 20314.492137696565, 20460.59078818423, 20778.16887324509, 20859.582808343843, 21401.46496337592, 22228.0, 22508.88745556274, 22643.54712905741, 22644.88677556614, 22690.319290421274, 1013.0, 1051.5530899367777, 1052.1740433759462, 1052.5211028981794, 1053.6470282455386, 1076.8277075667895, 1123.3989815448735, 1124.0557931337717, 1124.3085502415995, 1125.5104029747085, 1159.5825502818977, 1162.9069674426025, 1162.970925726855, 1163.2438914705424, 1166.1603645375317, 1155.7919574476591, 1156.4738044189914, 1158.1140427572914, 1158.6697791129488, 1164.126904821384, 853.3301358433599, 853.7225401744458, 853.906070332263, 855.0210009539105, 859.4499520307008, 19304.61390772191, 19620.509487262934, 19684.409467715992, 20567.280145194847, 21288.361349159397, 23145.189918352946, 23212.18757343485, 23249.883750581306, 23423.297301080995, 23724.40688982772, 17384.391546295945, 17632.91183544074, 17685.734713979302, 17929.0, 18034.90982545092, 4020.316546187126, 4059.8985025374304, 4060.3909413587903, 4061.4110953911813, 4063.065494936181, 141659.99999999898, 142722.0, 144735.0, 146399.0, 146588.26705866403, 17321.7401738974, 17440.738388924176, 17549.12254387301, 17720.645587088187, 17728.202230899384, 33517.32965340679, 34086.82956585251, 34486.82756586201, 34526.48210276848, 34600.48099278513, 9026.819463610691, 9119.270458363315, 9148.313876459291, 9151.862722059175, 9160.679376221933, 4109.938350924738, 4801.95198048022, 4823.204171311764, 4841.564259216688, 4842.346283251716, 6377.23473183221, 6573.934260657428, 6649.0, 6680.766173183915, 6689.264180940093, 1158.6697791129657, 1216.555957075661, 1232.6302109367155, 1240.4232032105115, 1244.8381710377594, 677.6814896998403, 692.3595674001629, 709.3013381818904, 715.8675645005691, 739.7928579997609, 12708.618741437771, 14346.713065738626, 14456.566303010926, 15151.166685832164, 15695.764563531557, 637.4040272345372, 700.5901547594714, 734.9669264882987, 740.6629983357559, 758.1963119093779, 6266.373362663697, 6636.83407914806, 6689.163854518185, 6900.689468973908, 6927.596474749704, 126167.0, 127232.0, 129031.35484322518, 132705.0, 133156.0, 104852.0, 110675.0, 112070.0, 112967.43516282366, 114963.0, 99854.0, 100272.49863750635, 101340.49329753451, 101923.49038254909, 105914.0, 13919.652008699864, 14136.363863625957, 14176.0, 14262.500812471513, 14298.499552515612, 49997.0, 50443.747781260856, 50883.49116508788, 50909.490905090475, 51362.0, 64205.0, 64683.35316646961, 65149.674251628436, 66535.0, 66590.33409665841, 18809.811901880807, 20069.297574585402, 20663.793362066186, 20799.480012999797, 20863.79136208679, 22454.32637020892, 22575.209867654554, 22608.208712694977, 22705.88647056754, 22722.43193920165, 19682.60634787325, 19951.700724488855, 21769.782302176776, 22032.11871525121, 22085.889570552044, 19488.415347539598, 19726.40820775379, 19776.40670779879, 19811.504712382306, 19846.90076549666, 20270.0, 20378.79621203769, 20949.476263092936, 20974.2659006934, 21009.054592543678, 14627.19550424737, 14762.704745905237, 14954.775678364616, 15132.0, 15703.057816531045, 15791.68416631638, 16109.113998730183, 16308.266128024505, 16322.59193520124, 16336.264868081202], "value": 10194.397817421617, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1435.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 105.0, 99.0, 106.0, 105.0, 105.0, 114.0, 97.0, 104.0, 109.0], "value": 104.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 112.0, 137.0, 166.0, 119.0, 141.0, 141.0, 112.0, 160.0, 114.0], "value": 134.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 162.0, 163.0, 162.0, 161.0, 163.0, 160.0, 163.0, 167.0], "value": 162.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 73.0, 184.0, 73.0, 73.0, 73.0, 75.0, 167.0, 74.0], "value": 94.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 130.0, 78.0, 78.0, 78.0, 132.0, 77.0, 82.0, 133.0], "value": 94.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 115.0], "value": 114.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 149.0, 149.0, 149.0, 150.0, 150.0, 149.0, 149.0, 151.0, 151.0], "value": 149.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 93.0, 94.0, 94.0, 94.0, 93.0, 93.0], "value": 93.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [43.0, 48.0, 55.0, 44.0, 44.0, 45.0, 43.0, 44.0, 43.0, 45.0], "value": 45.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 37.0, 38.0, 37.0, 37.0, 37.0, 37.0, 38.0, 38.0, 37.0], "value": 37.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 73.0, 73.0, 71.0, 72.0, 75.0, 72.0, 72.0, 72.0, 73.0], "value": 72.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 110.0, 110.0, 115.0, 127.0, 108.0, 110.0, 117.0, 119.0, 145.0], "value": 117.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 155.0, 154.0, 163.0, 163.0, 153.0, 151.0, 152.0, 152.0, 162.0], "value": 156.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 58.0, 60.0, 59.0, 59.0, 59.0, 62.0, 58.0, 59.0, 57.0], "value": 59.1, "unit": "score"}]}]} 06:03:39 INFO - Return code: 0 06:03:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:03:39 INFO - # TBPL SUCCESS # 06:03:39 INFO - Running post-action listener: _package_coverage_data 06:03:39 INFO - Running post-action listener: _resource_record_post_action 06:03:39 INFO - [mozharness: 2017-09-07 13:03:39.373021Z] Finished run-tests step (success) 06:03:39 INFO - Running post-run listener: _resource_record_post_run 06:03:39 INFO - Total resource usage - Wall time: 1183s; CPU: 13.0%; Read bytes: 434176; Write bytes: 387137536; Read time: 420; Write time: 257992 06:03:39 INFO - TinderboxPrint: CPU usage
13.1% 06:03:39 INFO - TinderboxPrint: I/O read bytes / time
434,176 / 420 06:03:39 INFO - TinderboxPrint: I/O write bytes / time
387,137,536 / 257,992 06:03:39 INFO - TinderboxPrint: CPU idle
8,198.5 (86.9%) 06:03:39 INFO - TinderboxPrint: CPU user
1,182.5 (12.5%) 06:03:39 INFO - TinderboxPrint: Swap in / out
0 / 0 06:03:39 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 121098240; Read time: 0; Write time: 89564 06:03:39 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 06:03:39 INFO - run-tests - Wall time: 1167s; CPU: 13.0%; Read bytes: 434176; Write bytes: 266039296; Read time: 420; Write time: 168428 06:03:40 INFO - Running post-run listener: _upload_blobber_files 06:03:40 INFO - Blob upload gear active. 06:03:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:03:40 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 06:03:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:03:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:03:40 INFO - (blobuploader) - INFO - Open directory for files ... 06:03:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 06:03:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:03:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:03:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 06:03:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:03:41 INFO - (blobuploader) - INFO - Done attempting. 06:03:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 06:03:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:03:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:03:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 06:03:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:03:42 INFO - (blobuploader) - INFO - Done attempting. 06:03:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 06:03:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:03:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:03:43 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 06:03:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:03:43 INFO - (blobuploader) - INFO - Done attempting. 06:03:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:03:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:03:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:03:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:03:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:03:46 INFO - (blobuploader) - INFO - Done attempting. 06:03:46 INFO - (blobuploader) - INFO - Iteration through files over. 06:03:46 INFO - Return code: 0 06:03:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:03:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:03:46 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/97fb38baba8c539b36b7fe5f635aef06c5d63bae23e44eefd4517abac43ae62c71707283b52ac55bfb0b95b10e595103022d1b055dcebdd0717b7db57a3e0e76", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8e77b894eddf05a05e3476b032f344d79e7ebce8a9c5f6f93fb995dbcfea669b6629ebce32bf5c00f48fb18dc8a5cf07e5ddf314d4aa3fe70f7e3e4a822b86f6", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e93fda9fd68c12bff9ba337ec9fa67d71cb1158ce183b785343f7a8cce4ad4c436a9dd5a30b9f7bee14754041fcc15bd91498567c8f6e3aacb4627622cac8ed6", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fcb71a6ad13ed5f912d1b830a0ec069b6fc31ceea3cd43aeda641867199477a957358a32e77c0a17aa93507f8e452138a700985e398ed71eddfe2938e2d3cd0b"} 06:03:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:03:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:03:46 INFO - Contents: 06:03:46 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/97fb38baba8c539b36b7fe5f635aef06c5d63bae23e44eefd4517abac43ae62c71707283b52ac55bfb0b95b10e595103022d1b055dcebdd0717b7db57a3e0e76", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8e77b894eddf05a05e3476b032f344d79e7ebce8a9c5f6f93fb995dbcfea669b6629ebce32bf5c00f48fb18dc8a5cf07e5ddf314d4aa3fe70f7e3e4a822b86f6", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e93fda9fd68c12bff9ba337ec9fa67d71cb1158ce183b785343f7a8cce4ad4c436a9dd5a30b9f7bee14754041fcc15bd91498567c8f6e3aacb4627622cac8ed6", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fcb71a6ad13ed5f912d1b830a0ec069b6fc31ceea3cd43aeda641867199477a957358a32e77c0a17aa93507f8e452138a700985e398ed71eddfe2938e2d3cd0b"} 06:03:46 INFO - Running post-run listener: copy_logs_to_upload_dir 06:03:46 INFO - Copying logs to upload dir... 06:03:46 INFO - mkdir: /builds/slave/test/build/upload/logs 06:03:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.938070 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2017-09-07 06:03:46.805379) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-07 06:03:46.809729) ========= 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=0e2a256762fed810e2f0f810000001b3-1504788184.137758-2072291508 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/97fb38baba8c539b36b7fe5f635aef06c5d63bae23e44eefd4517abac43ae62c71707283b52ac55bfb0b95b10e595103022d1b055dcebdd0717b7db57a3e0e76", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8e77b894eddf05a05e3476b032f344d79e7ebce8a9c5f6f93fb995dbcfea669b6629ebce32bf5c00f48fb18dc8a5cf07e5ddf314d4aa3fe70f7e3e4a822b86f6", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e93fda9fd68c12bff9ba337ec9fa67d71cb1158ce183b785343f7a8cce4ad4c436a9dd5a30b9f7bee14754041fcc15bd91498567c8f6e3aacb4627622cac8ed6", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fcb71a6ad13ed5f912d1b830a0ec069b6fc31ceea3cd43aeda641867199477a957358a32e77c0a17aa93507f8e452138a700985e398ed71eddfe2938e2d3cd0b"} build_url:https://queue.taskcluster.net/v1/task/THhrxJvGRaSBpbmI92T5WQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011229 build_url: 'https://queue.taskcluster.net/v1/task/THhrxJvGRaSBpbmI92T5WQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/97fb38baba8c539b36b7fe5f635aef06c5d63bae23e44eefd4517abac43ae62c71707283b52ac55bfb0b95b10e595103022d1b055dcebdd0717b7db57a3e0e76", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8e77b894eddf05a05e3476b032f344d79e7ebce8a9c5f6f93fb995dbcfea669b6629ebce32bf5c00f48fb18dc8a5cf07e5ddf314d4aa3fe70f7e3e4a822b86f6", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e93fda9fd68c12bff9ba337ec9fa67d71cb1158ce183b785343f7a8cce4ad4c436a9dd5a30b9f7bee14754041fcc15bd91498567c8f6e3aacb4627622cac8ed6", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fcb71a6ad13ed5f912d1b830a0ec069b6fc31ceea3cd43aeda641867199477a957358a32e77c0a17aa93507f8e452138a700985e398ed71eddfe2938e2d3cd0b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-07 06:03:46.837538) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 06:03:46.837878) ========= 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=0e2a256762fed810e2f0f810000001b3-1504788184.137758-2072291508 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004546 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 06:03:46.920157) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-07 06:03:46.923312) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-07 06:03:46.923616) ========= ========= Total master_lag: 0.15 =========