builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-047 starttime: 1504653744.36 results: success (0) revision: 978d2539a8d1a49e9f9705204f3918772b337547 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-05 16:22:24.359811) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-05 16:22:24.360242) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-05 16:22:24.360529) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-05 16:22:24.378113) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-05 16:22:24.378531) ========= 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=03627c79f6bb3d1578c4a402000001ba-1504653743.516103-1680718200 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-05 16:22:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 69.2M=0s 2017-09-05 16:22:24 (69.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.204013 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-05 16:22:24.599822) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-05 16:22:24.600167) ========= 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=03627c79f6bb3d1578c4a402000001ba-1504653743.516103-1680718200 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022128 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-05 16:22:24.650799) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-05 16:22:24.651563) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 978d2539a8d1a49e9f9705204f3918772b337547 --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 978d2539a8d1a49e9f9705204f3918772b337547 --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=03627c79f6bb3d1578c4a402000001ba-1504653743.516103-1680718200 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-05 16:22:24,704 truncating revision to first 12 chars 2017-09-05 16:22:24,704 Setting DEBUG logging. 2017-09-05 16:22:24,704 attempt 1/10 2017-09-05 16:22:24,704 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/978d2539a8d1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-05 16:22:25,565 unpacking tar archive at: mozilla-central-978d2539a8d1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.193435 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-05 16:22:25.861249) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-05 16:22:25.861581) ========= script_repo_revision: 978d2539a8d1a49e9f9705204f3918772b337547 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-05 16:22:25.861947) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-05 16:22:25.862210) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-05 16:22:25.874804) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2017-09-05 16:22:25.875212) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=03627c79f6bb3d1578c4a402000001ba-1504653743.516103-1680718200 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:22:26 INFO - MultiFileLogger online at 20170905 16:22:26 in /builds/slave/test 16:22:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 16:22:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:22:26 INFO - {'append_to_log': False, 16:22:26 INFO - 'base_work_dir': '/builds/slave/test', 16:22:26 INFO - 'blob_upload_branch': 'Firefox', 16:22:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:22:26 INFO - 'branch': 'Firefox', 16:22:26 INFO - 'buildbot_json_path': 'buildprops.json', 16:22:26 INFO - 'code_coverage': False, 16:22:26 INFO - 'config_files': ('talos/linux_config.py',), 16:22:26 INFO - 'default_actions': ('clobber', 16:22:26 INFO - 'read-buildbot-config', 16:22:26 INFO - 'download-and-extract', 16:22:26 INFO - 'populate-webroot', 16:22:26 INFO - 'create-virtualenv', 16:22:26 INFO - 'install', 16:22:26 INFO - 'setup-mitmproxy', 16:22:26 INFO - 'run-tests'), 16:22:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:22:26 INFO - 'disable_ccov_upload': False, 16:22:26 INFO - 'disable_stylo': False, 16:22:26 INFO - 'download_minidump_stackwalk': True, 16:22:26 INFO - 'download_symbols': 'ondemand', 16:22:26 INFO - 'enable_stylo': False, 16:22:26 INFO - 'enable_webrender': False, 16:22:26 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 16:22:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:22:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:22:26 INFO - 'gecko_profile': False, 16:22:26 INFO - 'gecko_profile_interval': 0, 16:22:26 INFO - 'installer_path': 'installer.exe', 16:22:26 INFO - 'log_level': 'info', 16:22:26 INFO - 'log_name': 'talos', 16:22:26 INFO - 'log_to_console': True, 16:22:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:22:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:22:26 INFO - 'opt_config_files': (), 16:22:26 INFO - 'pip_index': False, 16:22:26 INFO - 'suite': 'dromaeojs-e10s', 16:22:26 INFO - 'system_bits': '32', 16:22:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:22:26 INFO - 'title': 'talos-linux64-ix-047', 16:22:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:22:26 INFO - 'use_talos_json': True, 16:22:26 INFO - 'verify': 'False', 16:22:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:22:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:22:26 INFO - 'work_dir': 'build'} 16:22:26 INFO - [mozharness: 2017-09-05 23:22:26.075303Z] Running clobber step. 16:22:26 INFO - Running pre-action listener: _resource_record_pre_action 16:22:26 INFO - Running main action method: clobber 16:22:26 INFO - rmtree: /builds/slave/test/build 16:22:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:22:27 INFO - Running post-action listener: _resource_record_post_action 16:22:27 INFO - [mozharness: 2017-09-05 23:22:27.154870Z] Finished clobber step (success) 16:22:27 INFO - [mozharness: 2017-09-05 23:22:27.154968Z] Running read-buildbot-config step. 16:22:27 INFO - Running pre-action listener: _resource_record_pre_action 16:22:27 INFO - Running main action method: read_buildbot_config 16:22:27 INFO - Using buildbot properties: 16:22:27 INFO - { 16:22:27 INFO - "project": "", 16:22:27 INFO - "product": "firefox", 16:22:27 INFO - "who": "archaeopteryx@coole-files.de", 16:22:27 INFO - "installer_path": "public/build/target.tar.bz2", 16:22:27 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 16:22:27 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 16:22:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 16:22:27 INFO - "stage_platform": "linux64-pgo", 16:22:27 INFO - "basedir": "/builds/slave/test", 16:22:27 INFO - "buildnumber": 160, 16:22:27 INFO - "platform": "ubuntu64_hw", 16:22:27 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:22:27 INFO - "slavebuilddir": "test", 16:22:27 INFO - "taskId": "UfRcSDAnT6GFDFJ7-jOmDw", 16:22:27 INFO - "branch": "mozilla-central", 16:22:27 INFO - "script_repo_revision": "production", 16:22:27 INFO - "revision": "978d2539a8d1a49e9f9705204f3918772b337547", 16:22:27 INFO - "slavename": "talos-linux64-ix-047", 16:22:27 INFO - "repo_path": "mozilla-central" 16:22:27 INFO - } 16:22:27 INFO - Finding installer, test and symbols from parent task. 16:22:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UfRcSDAnT6GFDFJ7-jOmDw'}, attempt #1 16:22:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UfRcSDAnT6GFDFJ7-jOmDw'}, attempt #1 16:22:28 INFO - Task dependencies: dnzV977BRkOJkNzKYtz86g 16:22:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dnzV977BRkOJkNzKYtz86g'}, attempt #1 16:22:28 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/dnzV977BRkOJkNzKYtz86g/artifacts/public/build/target.tar.bz2 16:22:28 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/dnzV977BRkOJkNzKYtz86g/artifacts/public/build/target.test_packages.json 16:22:28 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/dnzV977BRkOJkNzKYtz86g/artifacts/public/build/target.crashreporter-symbols.zip 16:22:28 INFO - Running post-action listener: _resource_record_post_action 16:22:28 INFO - [mozharness: 2017-09-05 23:22:28.655107Z] Finished read-buildbot-config step (success) 16:22:28 INFO - [mozharness: 2017-09-05 23:22:28.655322Z] Running download-and-extract step. 16:22:28 INFO - Running pre-action listener: _resource_record_pre_action 16:22:28 INFO - Running main action method: download_and_extract 16:22:28 INFO - mkdir: /builds/slave/test/build/tests 16:22:28 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')]} 16:22:28 INFO - trying https://queue.taskcluster.net/v1/task/dnzV977BRkOJkNzKYtz86g/artifacts/public/build/target.test_packages.json 16:22:28 INFO - Downloading https://queue.taskcluster.net/v1/task/dnzV977BRkOJkNzKYtz86g/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:22:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dnzV977BRkOJkNzKYtz86g/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:22:29 INFO - Downloaded 989 bytes. 16:22:29 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:22:29 INFO - Using the following test package requirements: 16:22:29 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 16:22:29 INFO - u'common': [u'target.common.tests.zip'], 16:22:29 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:22:29 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:22:29 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:22:29 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:22:29 INFO - u'mozbase': [u'target.common.tests.zip'], 16:22:29 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:22:29 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:22:29 INFO - u'web-platform': [u'target.common.tests.zip', 16:22:29 INFO - u'target.web-platform.tests.tar.gz'], 16:22:29 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:22:29 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 16:22:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dnzV977BRkOJkNzKYtz86g/artifacts/public/build/target.common.tests.zip 16:22:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dnzV977BRkOJkNzKYtz86g/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:22:29 INFO - Fetch https://queue.taskcluster.net/v1/task/dnzV977BRkOJkNzKYtz86g/artifacts/public/build/target.common.tests.zip into memory 16:22:30 INFO - Content-Length response header: 55682095 16:22:30 INFO - Bytes received: 55682095 16:22:41 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 16:22:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dnzV977BRkOJkNzKYtz86g/artifacts/public/build/target.common.tests.zip 16:22:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dnzV977BRkOJkNzKYtz86g/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:22:41 INFO - Fetch https://queue.taskcluster.net/v1/task/dnzV977BRkOJkNzKYtz86g/artifacts/public/build/target.common.tests.zip into memory 16:22:42 INFO - Content-Length response header: 55682095 16:22:42 INFO - Bytes received: 55682095 16:22:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dnzV977BRkOJkNzKYtz86g/artifacts/public/build/target.talos.tests.zip 16:22:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dnzV977BRkOJkNzKYtz86g/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:22:54 INFO - Fetch https://queue.taskcluster.net/v1/task/dnzV977BRkOJkNzKYtz86g/artifacts/public/build/target.talos.tests.zip into memory 16:22:54 INFO - Content-Length response header: 14496654 16:22:54 INFO - Bytes received: 14496654 16:22: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')]} 16:22:55 INFO - trying https://queue.taskcluster.net/v1/task/dnzV977BRkOJkNzKYtz86g/artifacts/public/build/target.tar.bz2 16:22:55 INFO - Downloading https://queue.taskcluster.net/v1/task/dnzV977BRkOJkNzKYtz86g/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:22:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dnzV977BRkOJkNzKYtz86g/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:22:56 INFO - Downloaded 63507543 bytes. 16:22:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dnzV977BRkOJkNzKYtz86g/artifacts/public/build/target.tar.bz2 16:22:56 INFO - mkdir: /builds/slave/test/properties 16:22:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:22:56 INFO - Writing to file /builds/slave/test/properties/build_url 16:22:56 INFO - Contents: 16:22:56 INFO - build_url:https://queue.taskcluster.net/v1/task/dnzV977BRkOJkNzKYtz86g/artifacts/public/build/target.tar.bz2 16:22:56 INFO - Running post-action listener: _resource_record_post_action 16:22:56 INFO - Running post-action listener: find_tests_for_verification 16:22:56 INFO - Running post-action listener: set_extra_try_arguments 16:22:56 INFO - [mozharness: 2017-09-05 23:22:56.197949Z] Finished download-and-extract step (success) 16:22:56 INFO - [mozharness: 2017-09-05 23:22:56.198046Z] Running populate-webroot step. 16:22:56 INFO - Running pre-action listener: _resource_record_pre_action 16:22:56 INFO - Running main action method: populate_webroot 16:22:56 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:22:56 INFO - 'chromez-stylo-e10s': {'talos_options': ['--enable-stylo'], 16:22:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:22:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:22:56 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--enable-stylo'], 16:22:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:22:56 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:22:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:22:56 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 16:22:56 INFO - 'talos_options': ['--enable-stylo'], 16:22:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:22:56 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:22:56 INFO - 'tests': ['damp', 'tps']}, 16:22:56 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 16:22:56 INFO - 'talos_options': ['--enable-stylo'], 16:22:56 INFO - 'tests': ['damp', 'tps']}, 16:22:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:22:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 16:22:56 INFO - 'g4-stylo-e10s': {'talos_options': ['--enable-stylo'], 16:22:56 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 16:22:56 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 16:22:56 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 16:22:56 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 16:22:56 INFO - 'talos_options': ['--enable-stylo'], 16:22:56 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 16:22:56 INFO - 'other-e10s': {'tests': ['a11yr', 16:22:56 INFO - 'ts_paint', 16:22:56 INFO - 'tpaint', 16:22:56 INFO - 'sessionrestore', 16:22:56 INFO - 'sessionrestore_many_windows', 16:22:56 INFO - 'sessionrestore_no_auto_restore', 16:22:56 INFO - 'tabpaint']}, 16:22:56 INFO - 'other-stylo-e10s': {'talos_options': ['--enable-stylo'], 16:22:56 INFO - 'tests': ['a11yr', 16:22:56 INFO - 'ts_paint', 16:22:56 INFO - 'tpaint', 16:22:56 INFO - 'sessionrestore', 16:22:56 INFO - 'sessionrestore_many_windows', 16:22:56 INFO - 'sessionrestore_no_auto_restore', 16:22:56 INFO - 'tabpaint']}, 16:22:56 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 16:22:56 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 16:22:56 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--enable-stylo'], 16:22:56 INFO - 'tests': ['bloom_basic_singleton']}, 16:22:56 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--enable-stylo'], 16:22:56 INFO - 'tests': ['bloom_basic']}, 16:22:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:22:56 INFO - 'tsvgr_opacity', 16:22:56 INFO - 'tart', 16:22:56 INFO - 'tscrollx', 16:22:56 INFO - 'tsvg_static']}, 16:22:56 INFO - 'svgr-stylo-e10s': {'talos_options': ['--enable-stylo'], 16:22:56 INFO - 'tests': ['tsvgx', 16:22:56 INFO - 'tsvgr_opacity', 16:22:56 INFO - 'tart', 16:22:56 INFO - 'tscrollx', 16:22:56 INFO - 'tsvg_static']}, 16:22:56 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:22:56 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 16:22:56 INFO - 'talos_options': ['--enable-stylo'], 16:22:56 INFO - 'tests': ['tp5o']}, 16:22:56 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:22:56 INFO - 'talos_options': ['--mitmproxy', 16:22:56 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:22:56 INFO - '--firstNonBlankPaint'], 16:22:56 INFO - 'tests': ['tp6_google', 16:22:56 INFO - 'tp6_youtube', 16:22:56 INFO - 'tp6_amazon', 16:22:56 INFO - 'tp6_facebook']}, 16:22:56 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:22:56 INFO - 'talos_options': ['--enable-stylo', 16:22:56 INFO - '--mitmproxy', 16:22:56 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:22:56 INFO - '--firstNonBlankPaint'], 16:22:56 INFO - 'tests': ['tp6_google', 16:22:56 INFO - 'tp6_youtube', 16:22:56 INFO - 'tp6_amazon', 16:22:56 INFO - 'tp6_facebook']}, 16:22:56 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:22:56 INFO - 'talos_options': ['--enable-stylo', 16:22:56 INFO - '--stylo-threads=1', 16:22:56 INFO - '--mitmproxy', 16:22:56 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:22:56 INFO - '--firstNonBlankPaint'], 16:22:56 INFO - 'tests': ['tp6_google', 16:22:56 INFO - 'tp6_youtube', 16:22:56 INFO - 'tp6_amazon', 16:22:56 INFO - 'tp6_facebook']}, 16:22:56 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:22:56 INFO - 'talos_options': ['--xperf_path', 16:22:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:22:56 INFO - 'tests': ['tp5n']}, 16:22:56 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 16:22:56 INFO - 'talos_options': ['--enable-stylo', 16:22:56 INFO - '--xperf_path', 16:22:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:22:56 INFO - 'tests': ['tp5n']}}} 16:22:56 INFO - Running post-action listener: _resource_record_post_action 16:22:56 INFO - [mozharness: 2017-09-05 23:22:56.212343Z] Finished populate-webroot step (success) 16:22:56 INFO - [mozharness: 2017-09-05 23:22:56.212432Z] Running create-virtualenv step. 16:22:56 INFO - Running pre-action listener: _resource_record_pre_action 16:22:56 INFO - Running main action method: create_virtualenv 16:22:56 INFO - Creating virtualenv /builds/slave/test/build/venv 16:22:56 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:22:56 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 16:22:56 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 16:22:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:22:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:22:56 INFO - Installing distribute.............................................................................................................................................................................................done. 16:22:57 INFO - Installing pip...............done. 16:22:57 INFO - Return code: 0 16:22:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:22:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:22:57 INFO - Reading from file tmpfile_stdout 16:22:57 INFO - Output received: 16:22:57 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 16:22:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:22:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:22:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:22:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:22:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:22:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2060090>, '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 0x2060d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205af90>, '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': '03627c79f6bb3d1578c4a402000001ba-1504653743.516103-1680718200', '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 16:22:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:22:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:22:57 INFO - Using env: {'DISPLAY': ':0', 16:22:57 INFO - 'HOME': '/home/cltbld', 16:22:57 INFO - 'LANG': 'en_US.UTF-8', 16:22:57 INFO - 'LANGUAGE': 'en_US:en', 16:22:57 INFO - 'LOGNAME': 'cltbld', 16:22:57 INFO - 'MAIL': '/var/mail/cltbld', 16:22:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:22:57 INFO - 'MOZ_NO_REMOTE': '1', 16:22:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:22:57 INFO - 'NO_EM_RESTART': '1', 16:22:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:22:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:22:57 INFO - 'PWD': '/builds/slave/test', 16:22:57 INFO - 'SHELL': '/bin/bash', 16:22:57 INFO - 'SHLVL': '1', 16:22:57 INFO - 'TERM': 'linux', 16:22:57 INFO - 'TMOUT': '86400', 16:22:57 INFO - 'USER': 'cltbld', 16:22:57 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1504653743.516103-1680718200', 16:22:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:22:57 INFO - '_': '/tools/buildbot/bin/python'} 16:22:58 INFO - Ignoring indexes: http://pypi.python.org/simple/ 16:22:58 INFO - Downloading/unpacking pip>=1.5 16:22:58 INFO - Running setup.py egg_info for package pip 16:22:58 INFO - warning: no files found matching 'pip/cacert.pem' 16:22:58 INFO - warning: no files found matching '*.html' under directory 'docs' 16:22:58 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 16:22:58 INFO - no previously-included directories found matching 'docs/_build/_sources' 16:22:58 INFO - Installing collected packages: pip 16:22:58 INFO - Found existing installation: pip 1.1 16:22:58 INFO - Uninstalling pip: 16:22:58 INFO - Successfully uninstalled pip 16:22:58 INFO - Running setup.py install for pip 16:22:58 INFO - warning: no files found matching 'pip/cacert.pem' 16:22:58 INFO - warning: no files found matching '*.html' under directory 'docs' 16:22:58 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 16:22:58 INFO - no previously-included directories found matching 'docs/_build/_sources' 16:22:58 INFO - Installing pip script to /builds/slave/test/build/venv/bin 16:22:58 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 16:22:58 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 16:22:58 INFO - Successfully installed pip 16:22:58 INFO - Cleaning up... 16:22:58 INFO - Return code: 0 16:22:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:22:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:22:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:22:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:22:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:22:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2060090>, '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 0x2060d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205af90>, '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': '03627c79f6bb3d1578c4a402000001ba-1504653743.516103-1680718200', '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 16:22:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 16:22:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 16:22:58 INFO - Using env: {'DISPLAY': ':0', 16:22:58 INFO - 'HOME': '/home/cltbld', 16:22:58 INFO - 'LANG': 'en_US.UTF-8', 16:22:58 INFO - 'LANGUAGE': 'en_US:en', 16:22:58 INFO - 'LOGNAME': 'cltbld', 16:22:58 INFO - 'MAIL': '/var/mail/cltbld', 16:22:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:22:58 INFO - 'MOZ_NO_REMOTE': '1', 16:22:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:22:58 INFO - 'NO_EM_RESTART': '1', 16:22:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:22:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:22:58 INFO - 'PWD': '/builds/slave/test', 16:22:58 INFO - 'SHELL': '/bin/bash', 16:22:58 INFO - 'SHLVL': '1', 16:22:58 INFO - 'TERM': 'linux', 16:22:58 INFO - 'TMOUT': '86400', 16:22:58 INFO - 'USER': 'cltbld', 16:22:58 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1504653743.516103-1680718200', 16:22:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:22:58 INFO - '_': '/tools/buildbot/bin/python'} 16:22:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:22:58 INFO - Downloading/unpacking psutil>=3.1.1 16:22:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:22:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:22:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:22:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:22:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:22:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:22:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:22:59 INFO - Installing collected packages: psutil 16:22:59 INFO - Running setup.py install for psutil 16:22:59 INFO - building 'psutil._psutil_linux' extension 16:22:59 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 16:23:00 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 16:23:00 INFO - building 'psutil._psutil_posix' extension 16:23:00 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 16:23:00 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 16:23:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:23:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:23:00 INFO - Successfully installed psutil 16:23:00 INFO - Cleaning up... 16:23:00 INFO - Return code: 0 16:23:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:23:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:23:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:23:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:23:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2060090>, '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 0x2060d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205af90>, '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': '03627c79f6bb3d1578c4a402000001ba-1504653743.516103-1680718200', '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 16:23:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:23:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:23:00 INFO - Using env: {'DISPLAY': ':0', 16:23:00 INFO - 'HOME': '/home/cltbld', 16:23:00 INFO - 'LANG': 'en_US.UTF-8', 16:23:00 INFO - 'LANGUAGE': 'en_US:en', 16:23:00 INFO - 'LOGNAME': 'cltbld', 16:23:00 INFO - 'MAIL': '/var/mail/cltbld', 16:23:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:00 INFO - 'MOZ_NO_REMOTE': '1', 16:23:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:00 INFO - 'NO_EM_RESTART': '1', 16:23:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:00 INFO - 'PWD': '/builds/slave/test', 16:23:00 INFO - 'SHELL': '/bin/bash', 16:23:00 INFO - 'SHLVL': '1', 16:23:00 INFO - 'TERM': 'linux', 16:23:00 INFO - 'TMOUT': '86400', 16:23:00 INFO - 'USER': 'cltbld', 16:23:00 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1504653743.516103-1680718200', 16:23:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:00 INFO - '_': '/tools/buildbot/bin/python'} 16:23:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:23:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:23:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:23:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:23:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:23:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:23:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:23:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:23:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:23:01 INFO - Installing collected packages: mozsystemmonitor 16:23:01 INFO - Running setup.py install for mozsystemmonitor 16:23:01 INFO - Successfully installed mozsystemmonitor 16:23:01 INFO - Cleaning up... 16:23:01 INFO - Return code: 0 16:23:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:23:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:23:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:23:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:23:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2060090>, '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 0x2060d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205af90>, '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': '03627c79f6bb3d1578c4a402000001ba-1504653743.516103-1680718200', '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 16:23:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:23:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:23:01 INFO - Using env: {'DISPLAY': ':0', 16:23:01 INFO - 'HOME': '/home/cltbld', 16:23:01 INFO - 'LANG': 'en_US.UTF-8', 16:23:01 INFO - 'LANGUAGE': 'en_US:en', 16:23:01 INFO - 'LOGNAME': 'cltbld', 16:23:01 INFO - 'MAIL': '/var/mail/cltbld', 16:23:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:01 INFO - 'MOZ_NO_REMOTE': '1', 16:23:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:01 INFO - 'NO_EM_RESTART': '1', 16:23:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:01 INFO - 'PWD': '/builds/slave/test', 16:23:01 INFO - 'SHELL': '/bin/bash', 16:23:01 INFO - 'SHLVL': '1', 16:23:01 INFO - 'TERM': 'linux', 16:23:01 INFO - 'TMOUT': '86400', 16:23:01 INFO - 'USER': 'cltbld', 16:23:01 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1504653743.516103-1680718200', 16:23:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:01 INFO - '_': '/tools/buildbot/bin/python'} 16:23:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:23:02 INFO - Downloading/unpacking jsonschema==2.5.1 16:23:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:23:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:23:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:23:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:23:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:23:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:23:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:23:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:23:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:23:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:23:03 INFO - Downloading functools32-3.2.3-2.tar.gz 16:23:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:23:03 INFO - warning: no files found matching '*.txt' 16:23:03 INFO - no previously-included directories found matching 'build' 16:23:03 INFO - no previously-included directories found matching 'dist' 16:23:03 INFO - no previously-included directories found matching '.git*' 16:23:03 INFO - Installing collected packages: jsonschema, functools32 16:23:03 INFO - Running setup.py install for functools32 16:23:03 INFO - warning: no files found matching '*.txt' 16:23:03 INFO - no previously-included directories found matching 'build' 16:23:03 INFO - no previously-included directories found matching 'dist' 16:23:03 INFO - no previously-included directories found matching '.git*' 16:23:03 INFO - Successfully installed jsonschema functools32 16:23:03 INFO - Cleaning up... 16:23:03 INFO - Return code: 0 16:23:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:23:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:23:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:23:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:23:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2060090>, '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 0x2060d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205af90>, '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': '03627c79f6bb3d1578c4a402000001ba-1504653743.516103-1680718200', '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 16:23:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:23:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 16:23:03 INFO - Using env: {'DISPLAY': ':0', 16:23:03 INFO - 'HOME': '/home/cltbld', 16:23:03 INFO - 'LANG': 'en_US.UTF-8', 16:23:03 INFO - 'LANGUAGE': 'en_US:en', 16:23:03 INFO - 'LOGNAME': 'cltbld', 16:23:03 INFO - 'MAIL': '/var/mail/cltbld', 16:23:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:03 INFO - 'MOZ_NO_REMOTE': '1', 16:23:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:03 INFO - 'NO_EM_RESTART': '1', 16:23:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:03 INFO - 'PWD': '/builds/slave/test', 16:23:03 INFO - 'SHELL': '/bin/bash', 16:23:03 INFO - 'SHLVL': '1', 16:23:03 INFO - 'TERM': 'linux', 16:23:03 INFO - 'TMOUT': '86400', 16:23:03 INFO - 'USER': 'cltbld', 16:23:03 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1504653743.516103-1680718200', 16:23:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:03 INFO - '_': '/tools/buildbot/bin/python'} 16:23:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:23:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:23:03 INFO - Cleaning up... 16:23:03 INFO - Return code: 0 16:23:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:23:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:23:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:23:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:23:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1cf01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2060090>, '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 0x2060d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205af90>, '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': '03627c79f6bb3d1578c4a402000001ba-1504653743.516103-1680718200', '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 16:23:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:23:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:23:03 INFO - Using env: {'DISPLAY': ':0', 16:23:03 INFO - 'HOME': '/home/cltbld', 16:23:03 INFO - 'LANG': 'en_US.UTF-8', 16:23:03 INFO - 'LANGUAGE': 'en_US:en', 16:23:03 INFO - 'LOGNAME': 'cltbld', 16:23:03 INFO - 'MAIL': '/var/mail/cltbld', 16:23:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:03 INFO - 'MOZ_NO_REMOTE': '1', 16:23:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:03 INFO - 'NO_EM_RESTART': '1', 16:23:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:03 INFO - 'PWD': '/builds/slave/test', 16:23:03 INFO - 'SHELL': '/bin/bash', 16:23:03 INFO - 'SHLVL': '1', 16:23:03 INFO - 'TERM': 'linux', 16:23:03 INFO - 'TMOUT': '86400', 16:23:03 INFO - 'USER': 'cltbld', 16:23:03 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1504653743.516103-1680718200', 16:23:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:03 INFO - '_': '/tools/buildbot/bin/python'} 16:23:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:23:03 INFO - Downloading/unpacking blobuploader==1.2.4 16:23:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:23:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:23:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:23:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:23:05 INFO - Downloading blobuploader-1.2.4.tar.gz 16:23:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:23:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:23:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:23:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:23:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:23:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:23:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:23:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:23:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:23:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:23:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:23:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:23:05 INFO - Downloading docopt-0.6.1.tar.gz 16:23:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:23:05 INFO - Installing collected packages: blobuploader, requests, docopt 16:23:05 INFO - Running setup.py install for blobuploader 16:23:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:23:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:23:05 INFO - Running setup.py install for requests 16:23:06 INFO - Running setup.py install for docopt 16:23:06 INFO - Successfully installed blobuploader requests docopt 16:23:06 INFO - Cleaning up... 16:23:06 INFO - Return code: 0 16:23:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:23:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:23:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:23:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:23:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2060090>, '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 0x2060d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205af90>, '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': '03627c79f6bb3d1578c4a402000001ba-1504653743.516103-1680718200', '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 16:23:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:23:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:23:06 INFO - Using env: {'DISPLAY': ':0', 16:23:06 INFO - 'HOME': '/home/cltbld', 16:23:06 INFO - 'LANG': 'en_US.UTF-8', 16:23:06 INFO - 'LANGUAGE': 'en_US:en', 16:23:06 INFO - 'LOGNAME': 'cltbld', 16:23:06 INFO - 'MAIL': '/var/mail/cltbld', 16:23:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:06 INFO - 'MOZ_NO_REMOTE': '1', 16:23:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:06 INFO - 'NO_EM_RESTART': '1', 16:23:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:06 INFO - 'PWD': '/builds/slave/test', 16:23:06 INFO - 'SHELL': '/bin/bash', 16:23:06 INFO - 'SHLVL': '1', 16:23:06 INFO - 'TERM': 'linux', 16:23:06 INFO - 'TMOUT': '86400', 16:23:06 INFO - 'USER': 'cltbld', 16:23:06 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1504653743.516103-1680718200', 16:23:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:06 INFO - '_': '/tools/buildbot/bin/python'} 16:23:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:23:06 INFO - Running setup.py (path:/tmp/pip-PlOZNd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:23:06 INFO - Running setup.py (path:/tmp/pip-CdauBx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:23:06 INFO - Running setup.py (path:/tmp/pip-fbim96-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:23:06 INFO - Running setup.py (path:/tmp/pip-T9K3kW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:23:06 INFO - Running setup.py (path:/tmp/pip-gjrH2O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:23:06 INFO - Running setup.py (path:/tmp/pip-YrRnJz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:23:06 INFO - Running setup.py (path:/tmp/pip-Skv5w8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:23:06 INFO - Running setup.py (path:/tmp/pip-8hGv8Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:23:07 INFO - Running setup.py (path:/tmp/pip-oH3Hl3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:23:07 INFO - Running setup.py (path:/tmp/pip-ouRLoN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:23:07 INFO - Running setup.py (path:/tmp/pip-t80mvh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:23:07 INFO - Running setup.py (path:/tmp/pip-DqBxig-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:23:07 INFO - Running setup.py (path:/tmp/pip-yFyGZ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:23:07 INFO - Running setup.py (path:/tmp/pip-yYqmLQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:23:07 INFO - Running setup.py (path:/tmp/pip-6s4Ex5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:23:07 INFO - Running setup.py (path:/tmp/pip-5rGUzo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:23:07 INFO - Running setup.py (path:/tmp/pip-DdqSN8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:23:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:23:07 INFO - Running setup.py install for manifestparser 16:23:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:23:07 INFO - Running setup.py install for mozcrash 16:23:07 INFO - Running setup.py install for mozdebug 16:23:07 INFO - Running setup.py install for mozdevice 16:23:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:23:08 INFO - Running setup.py install for mozfile 16:23:08 INFO - Running setup.py install for mozhttpd 16:23:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:23:08 INFO - Running setup.py install for mozinfo 16:23:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:23:08 INFO - Running setup.py install for mozInstall 16:23:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:23:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:23:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:23:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:23:08 INFO - Running setup.py install for mozleak 16:23:08 INFO - Running setup.py install for mozlog 16:23:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:23:08 INFO - Running setup.py install for moznetwork 16:23:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:23:08 INFO - Running setup.py install for mozprocess 16:23:08 INFO - Running setup.py install for mozprofile 16:23:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:23:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:23:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:23:08 INFO - Running setup.py install for mozrunner 16:23:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:23:09 INFO - Running setup.py install for mozscreenshot 16:23:09 INFO - Running setup.py install for moztest 16:23:09 INFO - Running setup.py install for mozversion 16:23:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:23:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:23:09 INFO - Cleaning up... 16:23:09 INFO - Return code: 0 16:23:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:23:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:23:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:23:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:23:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2060090>, '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 0x2060d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205af90>, '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': '03627c79f6bb3d1578c4a402000001ba-1504653743.516103-1680718200', '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 16:23:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:23:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:23:09 INFO - Using env: {'DISPLAY': ':0', 16:23:09 INFO - 'HOME': '/home/cltbld', 16:23:09 INFO - 'LANG': 'en_US.UTF-8', 16:23:09 INFO - 'LANGUAGE': 'en_US:en', 16:23:09 INFO - 'LOGNAME': 'cltbld', 16:23:09 INFO - 'MAIL': '/var/mail/cltbld', 16:23:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:09 INFO - 'MOZ_NO_REMOTE': '1', 16:23:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:09 INFO - 'NO_EM_RESTART': '1', 16:23:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:09 INFO - 'PWD': '/builds/slave/test', 16:23:09 INFO - 'SHELL': '/bin/bash', 16:23:09 INFO - 'SHLVL': '1', 16:23:09 INFO - 'TERM': 'linux', 16:23:09 INFO - 'TMOUT': '86400', 16:23:09 INFO - 'USER': 'cltbld', 16:23:09 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1504653743.516103-1680718200', 16:23:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:09 INFO - '_': '/tools/buildbot/bin/python'} 16:23:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:23:09 INFO - Running setup.py (path:/tmp/pip-Cu4dqI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:23:09 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)) 16:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:23:09 INFO - Running setup.py (path:/tmp/pip-kr7X9Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:23:09 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)) 16:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:23:09 INFO - Running setup.py (path:/tmp/pip-MU0RBv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:23:09 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)) 16:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:23:09 INFO - Running setup.py (path:/tmp/pip-DIqB4h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:23:09 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)) 16:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:23:09 INFO - Running setup.py (path:/tmp/pip-XXZw4G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:23:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 16:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:23:10 INFO - Running setup.py (path:/tmp/pip-nsbTuh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:23:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 16:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:23:10 INFO - Running setup.py (path:/tmp/pip-jAoPIR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:23:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 16:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:23:10 INFO - Running setup.py (path:/tmp/pip-wM0fsO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:23:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:23:10 INFO - Running setup.py (path:/tmp/pip-BQ4B5M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:23:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 16:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:23:10 INFO - Running setup.py (path:/tmp/pip-Q4w1VO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:23:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:23:10 INFO - Running setup.py (path:/tmp/pip-4d7QhJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:23:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 16:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:23:10 INFO - Running setup.py (path:/tmp/pip-2dmqFw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:23:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:23:10 INFO - Running setup.py (path:/tmp/pip-v3IE0k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:23:10 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)) 16:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:23:10 INFO - Running setup.py (path:/tmp/pip-oXyYPK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:23:10 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)) 16:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:23:10 INFO - Running setup.py (path:/tmp/pip-HQnBWQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:23:10 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)) 16:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:23:10 INFO - Running setup.py (path:/tmp/pip-AfJbU8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:23:10 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)) 16:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:23:10 INFO - Running setup.py (path:/tmp/pip-JY_TZ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:23:10 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)) 16:23:10 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)) 16:23:10 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)) 16:23:10 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)) 16:23:10 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)) 16:23:10 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)) 16:23:10 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)) 16:23:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:23:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:23:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:23:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:23:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:23:11 INFO - Downloading blessings-1.6.tar.gz 16:23:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:23:12 INFO - Installing collected packages: blessings 16:23:12 INFO - Running setup.py install for blessings 16:23:12 INFO - Successfully installed blessings 16:23:12 INFO - Cleaning up... 16:23:12 INFO - Return code: 0 16:23:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:23:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:23:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:23:12 INFO - Reading from file tmpfile_stdout 16:23:12 INFO - Current package versions: 16:23:12 INFO - argparse == 1.2.1 16:23:12 INFO - blessings == 1.6 16:23:12 INFO - blobuploader == 1.2.4 16:23:12 INFO - docopt == 0.6.1 16:23:12 INFO - functools32 == 3.2.3-2 16:23:12 INFO - jsonschema == 2.5.1 16:23:12 INFO - manifestparser == 1.1 16:23:12 INFO - mozInstall == 1.13 16:23:12 INFO - mozcrash == 1.0 16:23:12 INFO - mozdebug == 0.1 16:23:12 INFO - mozdevice == 0.51 16:23:12 INFO - mozfile == 1.2 16:23:12 INFO - mozhttpd == 0.7 16:23:12 INFO - mozinfo == 0.10 16:23:12 INFO - mozleak == 0.1 16:23:12 INFO - mozlog == 3.5 16:23:12 INFO - moznetwork == 0.27 16:23:12 INFO - mozprocess == 0.25 16:23:12 INFO - mozprofile == 0.28 16:23:12 INFO - mozrunner == 6.13 16:23:12 INFO - mozscreenshot == 0.1 16:23:12 INFO - mozsystemmonitor == 0.3 16:23:12 INFO - moztest == 0.8 16:23:12 INFO - mozversion == 1.4 16:23:12 INFO - psutil == 3.1.1 16:23:12 INFO - requests == 1.2.3 16:23:12 INFO - wsgiref == 0.1.2 16:23:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:23: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')]} 16:23:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:23: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')]} 16:23:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2060090>, '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 0x2060d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205af90>, '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': '03627c79f6bb3d1578c4a402000001ba-1504653743.516103-1680718200', '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 16:23:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 16:23:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:23:12 INFO - Using env: {'DISPLAY': ':0', 16:23:12 INFO - 'HOME': '/home/cltbld', 16:23:12 INFO - 'LANG': 'en_US.UTF-8', 16:23:12 INFO - 'LANGUAGE': 'en_US:en', 16:23:12 INFO - 'LOGNAME': 'cltbld', 16:23:12 INFO - 'MAIL': '/var/mail/cltbld', 16:23:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:12 INFO - 'MOZ_NO_REMOTE': '1', 16:23:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:12 INFO - 'NO_EM_RESTART': '1', 16:23:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:12 INFO - 'PWD': '/builds/slave/test', 16:23:12 INFO - 'SHELL': '/bin/bash', 16:23:12 INFO - 'SHLVL': '1', 16:23:12 INFO - 'TERM': 'linux', 16:23:12 INFO - 'TMOUT': '86400', 16:23:12 INFO - 'USER': 'cltbld', 16:23:12 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1504653743.516103-1680718200', 16:23:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:12 INFO - '_': '/tools/buildbot/bin/python'} 16:23:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:23:12 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)) 16:23:12 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)) 16:23:12 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)) 16:23:12 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)) 16:23:12 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)) 16:23:12 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)) 16:23:12 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)) 16:23:12 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)) 16:23:12 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)) 16:23:12 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 16:23:12 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 16:23:12 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 16:23:12 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 16:23:12 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 16:23:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 16:23:13 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)) 16:23:13 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)) 16:23:13 INFO - Installing collected packages: simplejson 16:23:13 INFO - Running setup.py install for simplejson 16:23:13 INFO - building 'simplejson._speedups' extension 16:23:13 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 16:23:14 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 16:23:14 INFO - Successfully installed simplejson 16:23:14 INFO - Cleaning up... 16:23:14 INFO - Return code: 0 16:23:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:23:14 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')]} 16:23:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:23:14 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')]} 16:23:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23:14 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 0x1cf01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2060090>, '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 0x2060d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205af90>, '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': '03627c79f6bb3d1578c4a402000001ba-1504653743.516103-1680718200', '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 16:23:14 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 16:23:14 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 16:23:14 INFO - Using env: {'DISPLAY': ':0', 16:23:14 INFO - 'HOME': '/home/cltbld', 16:23:14 INFO - 'LANG': 'en_US.UTF-8', 16:23:14 INFO - 'LANGUAGE': 'en_US:en', 16:23:14 INFO - 'LOGNAME': 'cltbld', 16:23:14 INFO - 'MAIL': '/var/mail/cltbld', 16:23:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:14 INFO - 'MOZ_NO_REMOTE': '1', 16:23:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:14 INFO - 'NO_EM_RESTART': '1', 16:23:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:14 INFO - 'PWD': '/builds/slave/test', 16:23:14 INFO - 'SHELL': '/bin/bash', 16:23:14 INFO - 'SHLVL': '1', 16:23:14 INFO - 'TERM': 'linux', 16:23:14 INFO - 'TMOUT': '86400', 16:23:14 INFO - 'USER': 'cltbld', 16:23:14 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1504653743.516103-1680718200', 16:23:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:14 INFO - '_': '/tools/buildbot/bin/python'} 16:23:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:23:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:23:15 INFO - Cleaning up... 16:23:15 INFO - Return code: 0 16:23:15 INFO - Running post-action listener: _resource_record_post_action 16:23:15 INFO - Running post-action listener: _start_resource_monitoring 16:23:15 INFO - Starting resource monitoring. 16:23:15 INFO - [mozharness: 2017-09-05 23:23:15.111379Z] Finished create-virtualenv step (success) 16:23:15 INFO - [mozharness: 2017-09-05 23:23:15.111891Z] Running install step. 16:23:15 INFO - Running pre-action listener: _resource_record_pre_action 16:23:15 INFO - Running main action method: install 16:23:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:23:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:23:15 INFO - Reading from file tmpfile_stdout 16:23:15 INFO - Detecting whether we're running mozinstall >=1.0... 16:23:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:23:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:23:15 INFO - Reading from file tmpfile_stdout 16:23:15 INFO - Output received: 16:23:15 INFO - Usage: mozinstall [options] installer 16:23:15 INFO - Options: 16:23:15 INFO - -h, --help show this help message and exit 16:23:15 INFO - -d DEST, --destination=DEST 16:23:15 INFO - Directory to install application into. [default: 16:23:15 INFO - "/builds/slave/test"] 16:23:15 INFO - --app=APP Application being installed. [default: firefox] 16:23:15 INFO - mkdir: /builds/slave/test/build/application 16:23:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:23:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 16:23:31 INFO - Reading from file tmpfile_stdout 16:23:31 INFO - Output received: 16:23:31 INFO - /builds/slave/test/build/application/firefox/firefox 16:23:31 INFO - Running post-action listener: _resource_record_post_action 16:23:31 INFO - [mozharness: 2017-09-05 23:23:31.878883Z] Finished install step (success) 16:23:31 INFO - [mozharness: 2017-09-05 23:23:31.879135Z] Running setup-mitmproxy step. 16:23:31 INFO - Running pre-action listener: _resource_record_pre_action 16:23:31 INFO - Running main action method: setup_mitmproxy 16:23:31 INFO - Skipping: mitmproxy is not required 16:23:31 INFO - Running post-action listener: _resource_record_post_action 16:23:31 INFO - [mozharness: 2017-09-05 23:23:31.880254Z] Finished setup-mitmproxy step (success) 16:23:31 INFO - [mozharness: 2017-09-05 23:23:31.880472Z] Running run-tests step. 16:23:31 INFO - Running pre-action listener: _resource_record_pre_action 16:23:31 INFO - Running pre-action listener: _set_gcov_prefix 16:23:31 INFO - Running main action method: run_tests 16:23:31 WARNING - Try message not found. 16:23:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:23:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:23:31 INFO - Python 2.7.3 16:23:31 INFO - Return code: 0 16:23:31 INFO - grabbing minidump binary from tooltool 16:23:31 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')]} 16:23:31 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 0x2060090>, '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 0x2060d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205af90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:23:31 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 16:23:31 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 16:23:31 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 16:23:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:23:32 INFO - Return code: 0 16:23:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:23:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:23:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:23:32 INFO - ENV: RUST_BACKTRACE is now full 16:23:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:23:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:23:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dnzV977BRkOJkNzKYtz86g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 16:23:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dnzV977BRkOJkNzKYtz86g/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-047 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 16:23:32 INFO - Using env: {'DISPLAY': ':0', 16:23:32 INFO - 'HOME': '/home/cltbld', 16:23:32 INFO - 'LANG': 'en_US.UTF-8', 16:23:32 INFO - 'LANGUAGE': 'en_US:en', 16:23:32 INFO - 'LOGNAME': 'cltbld', 16:23:32 INFO - 'MAIL': '/var/mail/cltbld', 16:23:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:23:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:23:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:32 INFO - 'MOZ_NO_REMOTE': '1', 16:23:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:23:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:32 INFO - 'NO_EM_RESTART': '1', 16:23:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:32 INFO - 'PWD': '/builds/slave/test', 16:23:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:23:32 INFO - 'RUST_BACKTRACE': 'full', 16:23:32 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:23:32 INFO - 'SHELL': '/bin/bash', 16:23:32 INFO - 'SHLVL': '1', 16:23:32 INFO - 'TERM': 'linux', 16:23:32 INFO - 'TMOUT': '86400', 16:23:32 INFO - 'USER': 'cltbld', 16:23:32 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1504653743.516103-1680718200', 16:23:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:32 INFO - '_': '/tools/buildbot/bin/python'} 16:23:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dnzV977BRkOJkNzKYtz86g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 16:23:32 INFO - mozversion application_buildid: 20170905215433 16:23:32 INFO - mozversion application_changeset: 978d2539a8d1a49e9f9705204f3918772b337547 16:23:32 INFO - mozversion application_display_name: Nightly 16:23:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:23:32 INFO - mozversion application_name: Firefox 16:23:32 INFO - mozversion application_remotingname: firefox 16:23:32 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:23:32 INFO - mozversion application_vendor: Mozilla 16:23:32 INFO - mozversion application_version: 57.0a1 16:23:32 INFO - mozversion platform_buildid: 20170905215433 16:23:32 INFO - mozversion platform_changeset: 978d2539a8d1a49e9f9705204f3918772b337547 16:23:32 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:23:32 INFO - mozversion platform_version: 57.0a1 16:23:32 INFO - using testdate: 1504653812 16:23:32 INFO - actual date: 1504653812 16:23:32 INFO - starting webserver on 'localhost:33093' 16:23:32 INFO - SUITE-START | Running 2 tests 16:23:32 INFO - TEST-START | dromaeo_css 16:23:32 INFO - Initialising browser for dromaeo_css test... 16:23:32 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:33093/getInfo.html -profile /tmp/tmputMBPo/profile 16:23:32 INFO - TEST-INFO | started process 10939 (/builds/slave/test/build/application/firefox/firefox http://localhost:33093/getInfo.html) 16:23:37 INFO - TEST-INFO | 10939: exit 0 16:23:37 INFO - Browser initialized. 16:23:37 INFO - Running cycle 1/1 for dromaeo_css test... 16:23:37 INFO - Using env: {'DISPLAY': ':0', 16:23:37 INFO - 'HOME': '/home/cltbld', 16:23:37 INFO - 'JSGC_DISABLE_POISONING': '1', 16:23:37 INFO - 'LANG': 'en_US.UTF-8', 16:23:37 INFO - 'LANGUAGE': 'en_US:en', 16:23:37 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 16:23:37 INFO - 'LOGNAME': 'cltbld', 16:23:37 INFO - 'MAIL': '/var/mail/cltbld', 16:23:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:23:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:23:37 INFO - 'MOZ_CRASHREPORTER': '1', 16:23:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:37 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 16:23:37 INFO - 'MOZ_NO_REMOTE': '1', 16:23:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:23:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:37 INFO - 'NO_EM_RESTART': '1', 16:23:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:37 INFO - 'PWD': '/builds/slave/test', 16:23:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:23:37 INFO - 'RUST_BACKTRACE': 'full', 16:23:37 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:23:37 INFO - 'SHELL': '/bin/bash', 16:23:37 INFO - 'SHLVL': '1', 16:23:37 INFO - 'TERM': 'linux', 16:23:37 INFO - 'TMOUT': '86400', 16:23:37 INFO - 'USER': 'cltbld', 16:23:37 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1504653743.516103-1680718200', 16:23:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:37 INFO - '_': '/tools/buildbot/bin/python'} 16:23:37 INFO - TEST-INFO | started process 11127 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmputMBPo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:23:38 INFO - PID 11127 | 16:23:38 INFO - PID 11127 | (/builds/slave/test/build/application/firefox/firefox:11179): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:23:38 INFO - PID 11127 | 16:23:48 INFO - PID 11127 | RSS: Main: 163565568 16:23:48 INFO - PID 11127 | 16:26:46 INFO - PID 11127 | Cycle 1(1): loaded http://localhost:33093/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33093/tests/dromaeo/cssquery-ext.html) 16:26:47 INFO - PID 11127 | RSS: Main: 166772736 16:26:47 INFO - PID 11127 | 16:29:48 INFO - PID 11127 | Cycle 1(1): loaded http://localhost:33093/tests/dromaeo/cssquery-ext.html (next: http://localhost:33093/tests/dromaeo/cssquery-jquery.html) 16:29:49 INFO - PID 11127 | RSS: Main: 163131392 16:29:49 INFO - PID 11127 | 16:32:51 INFO - PID 11127 | Cycle 1(1): loaded http://localhost:33093/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33093/tests/dromaeo/cssquery-mootools.html) 16:32:51 INFO - PID 11127 | RSS: Main: 165621760 16:32:51 INFO - PID 11127 | 16:35:53 INFO - PID 11127 | Cycle 1(1): loaded http://localhost:33093/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33093/tests/dromaeo/cssquery-prototype.html) 16:35:53 INFO - PID 11127 | RSS: Main: 163901440 16:35:53 INFO - PID 11127 | 16:38:57 INFO - PID 11127 | Cycle 1(1): loaded http://localhost:33093/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33093/tests/dromaeo/cssquery-yui.html) 16:38:57 INFO - PID 11127 | RSS: Main: 164663296 16:38:57 INFO - PID 11127 | 16:41:59 INFO - PID 11127 | Cycle 1(1): loaded http://localhost:33093/tests/dromaeo/cssquery-yui.html (next: http://localhost:33093/tests/dromaeo/cssquery-dojo.html) 16:41:59 INFO - PID 11127 | RSS: Main: 167985152 16:41:59 INFO - PID 11127 | 16:41:59 INFO - PID 11127 | __start_tp_report 16:41:59 INFO - PID 11127 | _x_x_mozilla_page_load 16:41:59 INFO - PID 11127 | _x_x_mozilla_page_load_details 16:41:59 INFO - PID 11127 | |i|pagename|runs| 16:41:59 INFO - PID 11127 | |0;dojo.html;3875.709321800864;3920.7451515651464;3925.5485619153806;3927;3941.2117576484693;6542.574732642375;6661.433778128859;6673.332666733324;6678.232003319614;6729.730810767575;6669.933300666992;6748.763793267224;6753.864922701543;6788.490863185269;6809.761658341959;6005.339412664614;6009.969950150243;6035.758569657209;6080.969595152018;6083.847903802418;5971.044632858721;6006.249218847644;6042.244719410074;6059.909101363483;6130.785422510213;6045.848853778669;6140.2324709411105;6143.754249830024;6144.5698801083945;6157.938420615781;6045.939540604581;6064.332923378425;6138.355472675349;6171.444569988677;6176.702892392558;6012.5791194616395;6033.48715359195;6036.879262414727;6102.511799056065;6119.632822030692;6688.4649228061635;6773.796786096425;6781.762638307685;6786.083878676414;6857.897131543031;7276.96361518189;7287.9271207287775;7311.524750891175;7392.039034925479;7406.666699998513;7254.746083887038;7313.378362839165;7354.595497247649;7362;7399.963000185018;6780;6855.828604284883;6876.209235937831;6877.140357455318;6883.105196324445;7456.4780465367985;7482.4388170887405;7536.924630753732;7554.2823431773895;7574.394048476109;7094.53885497441;7138.39323657495;7145.999560061596;7168.928310716826;7183.49715519919;7130.572165670076;7183.245759195209;7215.783526494213;7219.169795473587;7221.061262035902;7182.066331376992;7239.384652304508;7305.525140865827;7365.52124111931;7384.150822655356;7293.721338109685;7352.007478990375;7392.1499027611435;7392.371648409945;7398.889016664754;6152.415520525543;6161.44546990773;6236.594621349598;6243.125962365272;6256.5307601930035;5295.4439783822145;5345.251664766858;5370.03339398912;5391.16436952273;5414.864628384243;6262.718177682015;6283.340249273851;6295.338989406138;6302.527310451735;6321.1782468278825;7180.8922866157045;7189.7483588074165;7282.089738782653;7290.270972902667;7301.853962920712;6244.094606282064;6268.529860260407;6290.811275661737;6369.426751592379;6369.649669268235;6551.344865513411;6630.9668451657435;6641.203055633355;6655.134832471747;6706.631135287606;7160.749373771997;7224.819379515554;7261;7265.128184617774;7274.672639731225;7190.568565886064;7272.05463289769;7282.4902256841515;7346.77959661211;7374.188839227681;6960.129983752031;7076.469264805057;7115.53749006313;7190.496665233383;7257.818554536178;7201.603911784902;7226.819329516594;7236.0231368766645;7257.092863392076;7274.636268186676;7175.641217939186;7292.41660667156;7345.6694448751;7375.483716139819;7390.29792169743;6893.965530172317;6984.092068031124;6994.370506654425;7076.716931322895;7080.114985626797;6828.283030281749;6977.825554361181;7023.648817559204;7031.332023457763;7093.184283807428;6993.615351155735;6998.545094568837;7014.158301003912;7095.290470952863;7103.893441598483;6905.689243983932;6907.516473846783;7016.087908571853;7017.543859649107;7121.465890058163;6816.625085620339;6823.454123670193;6828.829279268058;6832.0435139081565;6861.073755043005 16:41:59 INFO - PID 11127 | |1;ext.html;885.8804061451706;938.2259635800463;966.5505539923934;980.6665733650561;981.9901800981988;42177.156456870885;43370.34944475835;43454.34818477726;43479.56520434795;43638.563614363884;40179;40284.19431611366;40328.59671403292;40569.797151014274;40655.59344406555;7314.817129571763;7407.592582407965;7415.147258065311;7418.591977441239;7433.145188303361;7269.273072692741;7357.521761085539;7360.815979600499;7363.889541656879;7371.705131794722;7338.853222935538;7987.241212084843;8163.346932245406;8163.95918020409;8172.550509721963;8041;8072.959635201845;8084.353251739905;8088.312493438036;8111.513309201467;7702.653380597886;7864.68541258349;7866.646000929972;7972.242636949481;8087.878681819778;38930;39218.41172382417;39226;39254.214915701814;39358.40962385567;3666.7066634669427;3707.1473561080834;3708.2768860072297;3710.07248187953;3716.8141592920515;32592.348153037045;32630.673693263;32695.6730432695;32740.836295818608;32750.508742368882;5385.7576409061685;5393.460653934614;5408.486193811582;5413.512783849433;5517.586181036439;204166;204338;205350;211728;219853;52746;53022.46977530175;53196.46803531915;53218.73390633022;53221.733891330296;55114.72442637761;55129;55139.44860551423;55420.72289638607;55425.445745542835;14608.269586520631;14639.268036598127;14661.92669036648;14758.63103422423;14886.106833589804;11916.404179790976;11924.880751192377;11925.88074119265;11935.104867135;11939.582114625946;15224.847751522564;15280.694386112216;15311.234438278041;15352.769708454382;15458.768118478232;5673.631213971161;5779.595428319977;5882.911566393954;5888.617239879394;5934.7922822701;1082.7293176705823;1091.2088735666737;1093.2456604942565;1097.8023955687893;1101.5758932810925;25857.74142258591;25876.74123258781;25893.223203303933;26103.869480652476;26245.606315905276;1157.9189456737947;1167.8890505401973;1178.8113901775846;1191.142377488207;1198.8681245063035;13052.934735326262;13208.33958302081;13423.26172060546;13558.93220533891;13603.523876664269;288994;296533;296722;296897;297417;59548.70225648844;60005;60169.39830601638;60663.39336606577;60736.39263607308;1486.2642991718951;1506.540505145941;1511.5767585076196;1521.2241756703938;1528.2206074901658;30590;30733.846330769098;31054.950984801046;31079;31767.841160794047;41537.58462415458;41726;41727.37408938929;41909.79045104877;42061.789691052574;256153;256158;258001;258149;258253;36794.632053680194;37301.6269837309;39532.60467395404;39627.80186099051;39717.80141099276;48137.51862481471;49469.257961131334;49688.503114968385;50085.499145008085;50261.74869125631;35487.467687984186;35935.281294373446;36022;36161.63838361688;36800.63199367972;35588;36120.638793611724;36343;36555.81722091373;36797.81601092085;41567.37648935208;42025.78987105045;42292;42355;42417.787911060244;35026;35134.12164695903;35168.472472912414;35534.822325888206;35665;25520.48959020772;26650;26820.195394138205;27109.72890271151;27485.17544473669 16:41:59 INFO - PID 11127 | |2;jquery.html;594.1207013619843;597.9073243647231;604.3744724210437;611.4099893602674;631.3591704420013;22144.114235430563;22676.65985010224;23463;23488.765112348872;23500.412489687766;26877.193684189457;27051.32371690709;27207.727922720765;27243.727562724365;27247.182584522445;6464.741410343592;6616.735330586795;6619.834504137387;6620.6358650274215;6622;6084.574079814415;6583.440407565363;6700.932990670104;6707.1616047994;6710.5302628816;6666.233383160926;6666.699998500055;6669;6671.432928201109;6678.632675202862;6644;6645.435138013275;6649.60102393858;6654.933450665504;6656.600603963753;6218.564700470969;6230.470410015154;6246.531510136758;6260.186175797163;6262.655553944532;29492.410151796845;30122.84938575315;30140.24649383783;31425.37149257002;31586;2200.0759680934048;2242.5627002734473;2247.101159536199;2247.9662805057937;2248.4266512039326;19560.217591296332;20353.287634932854;20812;20812.58374832495;20830.166793328248;2446.425090103824;2462.052109937669;2513.6857892763405;2522.0668352709613;2524.684414448194;151314.24342878326;154791;156354.43645563512;157062;157957;15836.841631583537;16099.517014489584;16197.190140492929;16380.26288817006;17080.48758537246;26118.216453506426;26142.477150456885;26246.86876565605;26277.73722262791;26286.86856565705;10124.595016199417;10251.794964100676;10284.897151028394;10314.432706201082;10342.793144137075;7881.408894332948;9018;9086.500727379907;9101.726948191565;9180.31147663928;8338.62476188573;9743.415395076318;9834.803303934024;10170.237232207613;10184.134348580454;2710.5256580098403;2788.344738986337;2811.8594070296404;2844.8293102413922;2880.222339968197;1056.4612047855649;1069.7165251208437;1070.7739638114315;1076.042322333124;1082.5886163257912;21849.126034958423;22006.559868802535;22014.44963875916;22041.779582204294;22224.222152224593;1078.6494389323502;1128.5880653561555;1128.9774204515863;1132.7904337697553;1151.8157094864948;11744.354060526754;12081.75836483283;14161.85838141626;14436.566902992927;15490.225488725519;645109;660919;668410;677783;694479;129712;136540.31729841288;136724;136920;137728.31135844457;1277.4187744576195;1302.433441452971;1325.3903204525834;1328.4022190014532;1333.046871486872;22719.318420447413;23227.88386058059;23303.18438854632;23304.533909322057;23403.53192936166;62901.37098629138;65049.34950650622;66334;67028.6648566754;67196.328036719;80230.19769802461;84473.15526844653;84569.57715211631;85500;85804.57097714471;13109.410076546768;13514.662133446742;14257.215853128178;15913.283902224197;16380.508584742476;24901.50196996086;25346.1128860489;25634.102806401686;25815.612765808903;25929.6110558338;20320.491987699836;20495.897520512302;20559.588808223452;20565.38303850887;20752.58494830125;17434.21546030406;17654.587632989074;17975.191116400056;18467.16897739578;18660.34688785886;20653.58692826165;21236.469088272916;21251.68122478195;21270.78729212688;21304.467388315417;15532.378704851679;16181.4336498222;16219.51341459758;16228.350865965229;16262.3495060201;20085.09617067265;20378.79621203769;20403.693944590545;20532.589348212652;20543.691844622044 16:41:59 INFO - PID 11127 | |3;mootools.html;1456.5994351553322;1506.1866592040299;1507.640542550907;1529.395888623993;1533.1491022482521;16779.664406711872;17448.3020679173;17458.56353591161;17460.650786984268;17487.825121748778;16554.420595279167;18135.093245337714;18141.27434902602;18142.727859082126;18145.364912228073;2866.011226126983;2899.898503552376;2904.5933569300314;2909.796314258003;2910.5738188287796;2815.9014434494798;2817.2534278416238;2885.552739325408;2886;2918.3871387008753;2848.886044558215;2907.215051935976;2924.1519959211805;2924.312786495172;2927.0340787540063;2738.192233291184;2770.5290100682932;2771.1686494051705;2774.3064233941413;2778.4859800936792;2735.617013618095;2737.5346191147355;2738.274357295318;2741.7258274172623;2751.408447183865;16432.342706291733;16470.6705865882;16593;16651.75022374653;16681.332746690117;8271.95864020682;8527.104654011302;8579.871301930476;8621.05168431472;8625.353098517637;5361.195820626898;5561.805336813192;5664.631798933056;5744.511716504102;5774.076147816371;2102.4638717127186;2154.149111101122;2171.356823979583;2175.3365223606793;2179.063002908749;29607.111786646434;29839;29849;29858.40283194346;29872.551911721122;7073.398761105261;7250.564966102051;7272.454565907472;7366.889496657554;7429.182789893108;19254.903725481283;19334.613307733765;19361.322353717835;19382.903085484766;19390.903045484683;8435.409521333571;8631.050584435707;8640.222379985706;8644.092370301154;8664.956675216583;7245.8550828983125;7401.259874012556;7403.555786652818;7841.921580784233;7912.525248484994;5450.781968721207;5632.070708333161;5651.9152212716845;5689.175069614966;5716.28546431696;1494.6562290673205;1532.8237252715858;1597.4089586852938;1611.9516414507584;1664.4507312586818;1003.6487229469773;1005.3615953869199;1005.5726316315537;1005.9144972677404;1025.9640912568025;9584.568694408768;9593.520323983774;9734.221262299;9746.707598772047;9923.801523969625;1050.495762034228;1066.4696161008976;1072.1369297715257;1082.3127314155568;1087.3856271206744;5664.8867022659315;5699.686517241592;5805.6806875621405;5868.471837534642;5959.0763431668165;23567.17514886971;23871.522569548513;24580.631290530655;24826.255212343658;24862.12982545602;23866.761332386453;24215.51568968646;24245.393865153514;24293.878530607235;24506.142285019938;12211;12504.437300321326;12786.29675367845;12788.36058197105;12800.679983000313;10165.288429809842;10287.485625718833;10298.794024119625;10490.580376784843;10652.307600005975;21185.788142119;21573.676394853777;21926.780732192474;21999.23002694898;22193;21582.460438488535;21588.784112159305;22008.229711960004;22068.448288792908;22087.33737987863;13013.414396351998;13192.73614527685;13199.934000329937;13200.339983001004;13584.456621735415;15576.610584735019;15816.446424375092;15864.206789660702;15876.285567149274;15890.046597204204;12625.873741262838;12645;12716.427760750603;12745.61763147107;12811.423485942969;12661.366931653565;12698.619041428772;12973.675658108245;13111.60665180046;13159.934200328937;11078.335299882034;11354.26197297173;11373;11380.658580242605;11442.82835757481;8295.12901145371;8383.790405239917;8385;8398.580070996304;8449.366297527833;8258.425846570932;8258.793530161794;8263.9586802068;8359.289460395934;8359.874601881098 16:41:59 INFO - PID 11127 | |4;prototype.html;543.5570010441489;553.1785298831235;579.2701196492418;584.4009889862891;586.9559783016272;6489.351064893508;6562.9015564766505;6695.163104611924;6721.764738234163;6764.241297262723;6631.303713110126;6647.900281495781;6674.566153200039;6698.933010669892;6718.764843230488;5059.3422855028975;5264.763085661154;5447.700376479283;5452.59105567082;5486.341639003325;5265.684058956455;5284.25619545549;5289.285946397225;5321.095413779647;5332.093544097494;5217.947820521803;5267.973660131694;5272.202295910722;5282.144034854558;5282.788688452457;5258.6318957672975;5259.447757985433;5270.341207349063;5279.155335146377;5280.894382112337;4793.257045158006;4795.592374648159;4795.976020119877;4821.421429428456;4825.855224343275;6443.935560644427;6477.74089036438;6666.899996500057;6729.360710732472;6752.189737231514;5993.9400605993815;6136.96931515344;6151.5551291277025;6160.9668809292825;6161.106639537242;7006.859862802716;7142.535735177197;7144.642767861586;7166.892496612555;7177.49757516974;5250.553702935255;5319.23399832089;5343.839684809462;5354.839354819362;5355.410904800468;6945.9233818758175;7225.313595208447;7226.855462890765;7255.2744725527555;7352.522086064442;5336.679799211982;5429.4299098594865;5434.565234781208;5437.8368648940595;5484.424135465799;5456.645318054314;5499.202615620713;5523.917141242885;5557.110862262019;5562.666240025612;6112.938870611237;6129.601575897553;6147.170132032118;6156.938430615636;6167.167432396569;7037.2962703730245;7081.610511421921;7119.21688614252;7142.821429464305;7156.320149585781;1890.650229707481;1890.8392786613017;1908.084119622589;1946.2094872717134;1948.5420926082359;1290.283892439705;1323.7617228898891;1332.8067430222757;1338.1903948111253;1350.8514063453013;6142.969285153635;6210.7515699371515;6241.843953901189;6272.776808522385;6287.779927702509;7049.4712896532965;7050.894236586353;7116.679749411289;7156.677949492286;7197.676104575202;6213.347598502182;6271.30333956394;6278.748850045947;6295.937040629535;6299.464545513591;3816.732828701964;3826.942595861064;3842.51968503937;3875.186210895687;3877.3408520551575;7107.92892071083;7169.100188450065;7211.3870321023305;7219.205887352387;7222.277772222736;7308.123025237006;7368.852622947511;7395.186529481753;7407.6666550005375;7511;7021.89467157993;7068.151821781419;7072.823179420556;7076.186238582629;7141.250168732208;7143.85712285741;7156.284371562802;7196.748113815991;7228.168760592599;7315.341619254293;7161.39128174111;7227.494075414881;7231.819204519929;7259.9274007261365;7263.818404539928;7058.023753349071;7080.2919708028785;7104.751333703295;7176.246494118252;7220.169680486812;5445.83662490126;5447.782088716565;5453.04571699943;5460.918086228789;5492.47821456961;6870.416014638811;7083.929160708327;7180.5691658500655;7268.0914885639295;7288.344049035612;6634.734610615521;6755.946432140676;6820.727170913108;6893.620850853051;6999.580025198505;6860.451163906776;6886.8622627546165;6898;6925.238223795278;7023.262557431396;6839.418649414855;6881.724731010703;6926.549774264657;6996.965015174892;7011.614361210182;6824.93175068243;6876.209235937931;6883.657686751236;7013.684384202621;7026.781298550717;6744.22441419243;6774.390304872585;6825.317468253135;6858.536439098223;6872.312768723088 16:41:59 INFO - PID 11127 | |5;yui.html;978.2614126334616;987.2644879564725;1010.7978404319138;1015.6496008876937;1021.3565453764128;18656.533586660342;19000.334988275412;19420.99999999998;19450.027498625084;20513.794862051374;21990.89004554975;22515.54968900621;22569.322920312377;22606.88696556519;22682.432939176528;1069.850220969063;1110.0897264243324;1110.7278716714377;1110.7556337605754;1111.1943840715458;975.6390135649784;1100.136392931549;1105.7898999190168;1105.8341248812662;1106.4744246482937;1140.1676775953558;1140.4696815980567;1141.1099342512812;1141.1270378160673;1141.2239677019622;1141.2467771270963;1141.4007645985882;1143.3482914738602;1143.394001179368;1144.347721798575;840.9621567029499;840.9873851892227;841.4194205997842;843.1442086282428;843.5739951324604;18329.633407331778;18330;18412.171452284547;19784;21556.461088472755;22299.888500557394;22723.318300451014;23223.651645225335;23231;23258.185963491367;18537.165827537658;18730.344437944743;18845.528861778428;18902.905485472624;19133.61732765337;4032.5160980682213;4039.5758445363404;4043.9797801010805;4047.534533528623;4060.1067765091634;138051;139989.3000535001;140726;141806;142943;17183.226754796066;17683.646327073642;17851.821481785017;17852.55368615795;17859.196336164903;32489.837550812095;32704.345913081605;33016.50475242873;33509.664903350655;33557.49663755046;9045;9194;9266;9289.72130836076;9316.068393160765;4403.2734598791485;4474.731516109044;4489.73061616304;4496.887577810516;4518;5980.880382392328;6178.907316390258;6191.473724733358;6259.937400626027;6278.968605156945;1070.9410982396043;1107.0479387726548;1110.0564520157964;1123.3540714089431;1125.358545629;756.76162008967;761.5773245848608;777.782220978127;782.440555003164;782.6243403166512;12587.93706031464;13041;13785.241811700253;14413.13521188732;14471.059381140192;726.5422783646269;731.3929438565978;735.7057177129191;742.0798210219289;752.6124046116255;5993.460588547052;6031.366706495843;6063.787767428119;6075.513958883279;6213.726186131922;128088;129768;130769;130838.34580827034;137259.31370343085;121435;122413;123512.38243808903;123514.38242808728;126152.36923815322;105110.47444762728;106158.93841061645;107507;109129;109334.45332773286;14247.21640309793;14677.192754398611;14715.926420368258;14774.852251477778;15010.624734381729;48682.75658621684;48912.75543622259;49040.5095949036;49522.50477495179;49535.504644953086;63895;64654;64749;66677;66951;20313.085911133738;20372;20720.067596957873;21358.679619805403;21386.786132139103;23273;23613;23665.171718989754;23721.288361349187;23972;21566.353009409115;21727.674084889055;21807.78192218121;22031.779682202974;22058.558828823654;20643.793562064187;21256.149754009668;21293.148274068863;21324.253651122137;21522.246721364678;20746.688799667714;21394.35816925495;21478;21541.892290538446;21676;13453.663658408617;14318.355673994487;14463.349149288097;14543.563693089225;14617.853821462075;14981.700365992838;15608.375664973273;16002.19989000522;16341.591460213589;16486.917565412095 16:41:59 INFO - PID 11127 | __end_tp_report 16:41:59 INFO - PID 11127 | __start_cc_report 16:41:59 INFO - PID 11127 | _x_x_mozilla_cycle_collect,362 16:41:59 INFO - PID 11127 | __end_cc_report 16:41:59 INFO - PID 11127 | __startTimestamp1504654919491__endTimestamp 16:41:59 INFO - PID 11127 | 16:41:59 INFO - PID 11127 | ------- Summary: start ------- 16:41:59 INFO - PID 11127 | Number of tests: 6 16:41:59 INFO - PID 11127 | 16:41:59 INFO - PID 11127 | [#0] dojo.html Cycles:165 Average:6717.52 Median:6905.69 stddev:721.14 (10.4%) stddev-sans-first:688.03 16:41:59 INFO - PID 11127 | Values: 3875.7 3920.7 3925.5 3927.0 3941.2 6542.6 6661.4 6673.3 6678.2 6729.7 6669.9 6748.8 6753.9 6788.5 6809.8 6005.3 6010.0 6035.8 6081.0 6083.8 5971.0 6006.2 6042.2 6059.9 6130.8 6045.8 6140.2 6143.8 6144.6 6157.9 6045.9 6064.3 6138.4 6171.4 6176.7 6012.6 6033.5 6036.9 6102.5 6119.6 6688.5 6773.8 6781.8 6786.1 6857.9 7277.0 7287.9 7311.5 7392.0 7406.7 7254.7 7313.4 7354.6 7362.0 7400.0 6780.0 6855.8 6876.2 6877.1 6883.1 7456.5 7482.4 7536.9 7554.3 7574.4 7094.5 7138.4 7146.0 7168.9 7183.5 7130.6 7183.2 7215.8 7219.2 7221.1 7182.1 7239.4 7305.5 7365.5 7384.2 7293.7 7352.0 7392.1 7392.4 7398.9 6152.4 6161.4 6236.6 6243.1 6256.5 5295.4 5345.3 5370.0 5391.2 5414.9 6262.7 6283.3 6295.3 6302.5 6321.2 7180.9 7189.7 7282.1 7290.3 7301.9 6244.1 6268.5 6290.8 6369.4 6369.6 6551.3 6631.0 6641.2 6655.1 6706.6 7160.7 7224.8 7261.0 7265.1 7274.7 7190.6 7272.1 7282.5 7346.8 7374.2 6960.1 7076.5 7115.5 7190.5 7257.8 7201.6 7226.8 7236.0 7257.1 7274.6 7175.6 7292.4 7345.7 7375.5 7390.3 6894.0 6984.1 6994.4 7076.7 7080.1 6828.3 6977.8 7023.6 7031.3 7093.2 6993.6 6998.5 7014.2 7095.3 7103.9 6905.7 6907.5 7016.1 7017.5 7121.5 6816.6 6823.5 6828.8 6832.0 6861.1 16:41:59 INFO - PID 11127 | 16:41:59 INFO - PID 11127 | [#1] ext.html Cycles:180 Average:43416.27 Median:20509.22 stddev:66807.58 (325.7%) stddev-sans-first:66918.67 16:41:59 INFO - PID 11127 | Values: 885.9 938.2 966.6 980.7 982.0 42177.2 43370.3 43454.3 43479.6 43638.6 40179.0 40284.2 40328.6 40569.8 40655.6 7314.8 7407.6 7415.1 7418.6 7433.1 7269.3 7357.5 7360.8 7363.9 7371.7 7338.9 7987.2 8163.3 8164.0 8172.6 8041.0 8073.0 8084.4 8088.3 8111.5 7702.7 7864.7 7866.6 7972.2 8087.9 38930.0 39218.4 39226.0 39254.2 39358.4 3666.7 3707.1 3708.3 3710.1 3716.8 32592.3 32630.7 32695.7 32740.8 32750.5 5385.8 5393.5 5408.5 5413.5 5517.6 204166.0 204338.0 205350.0 211728.0 219853.0 52746.0 53022.5 53196.5 53218.7 53221.7 55114.7 55129.0 55139.4 55420.7 55425.4 14608.3 14639.3 14661.9 14758.6 14886.1 11916.4 11924.9 11925.9 11935.1 11939.6 15224.8 15280.7 15311.2 15352.8 15458.8 5673.6 5779.6 5882.9 5888.6 5934.8 1082.7 1091.2 1093.2 1097.8 1101.6 25857.7 25876.7 25893.2 26103.9 26245.6 1157.9 1167.9 1178.8 1191.1 1198.9 13052.9 13208.3 13423.3 13558.9 13603.5 288994.0 296533.0 296722.0 296897.0 297417.0 59548.7 60005.0 60169.4 60663.4 60736.4 1486.3 1506.5 1511.6 1521.2 1528.2 30590.0 30733.8 31055.0 31079.0 31767.8 41537.6 41726.0 41727.4 41909.8 42061.8 256153.0 256158.0 258001.0 258149.0 258253.0 36794.6 37301.6 39532.6 39627.8 39717.8 48137.5 49469.3 49688.5 50085.5 50261.7 35487.5 35935.3 36022.0 36161.6 36800.6 35588.0 36120.6 36343.0 36555.8 36797.8 41567.4 42025.8 42292.0 42355.0 42417.8 35026.0 35134.1 35168.5 35534.8 35665.0 25520.5 26650.0 26820.2 27109.7 27485.2 16:41:59 INFO - PID 11127 | 16:41:59 INFO - PID 11127 | [#2] jquery.html Cycles:180 Average:42283.65 Median:23265.53 stddev:111605.75 (479.7%) stddev-sans-first:111874.94 16:41:59 INFO - PID 11127 | Values: 594.1 597.9 604.4 611.4 631.4 22144.1 22676.7 23463.0 23488.8 23500.4 26877.2 27051.3 27207.7 27243.7 27247.2 6464.7 6616.7 6619.8 6620.6 6622.0 6084.6 6583.4 6700.9 6707.2 6710.5 6666.2 6666.7 6669.0 6671.4 6678.6 6644.0 6645.4 6649.6 6654.9 6656.6 6218.6 6230.5 6246.5 6260.2 6262.7 29492.4 30122.8 30140.2 31425.4 31586.0 2200.1 2242.6 2247.1 2248.0 2248.4 19560.2 20353.3 20812.0 20812.6 20830.2 2446.4 2462.1 2513.7 2522.1 2524.7 151314.2 154791.0 156354.4 157062.0 157957.0 15836.8 16099.5 16197.2 16380.3 17080.5 26118.2 26142.5 26246.9 26277.7 26286.9 10124.6 10251.8 10284.9 10314.4 10342.8 7881.4 9018.0 9086.5 9101.7 9180.3 8338.6 9743.4 9834.8 10170.2 10184.1 2710.5 2788.3 2811.9 2844.8 2880.2 1056.5 1069.7 1070.8 1076.0 1082.6 21849.1 22006.6 22014.4 22041.8 22224.2 1078.6 1128.6 1129.0 1132.8 1151.8 11744.4 12081.8 14161.9 14436.6 15490.2 645109.0 660919.0 668410.0 677783.0 694479.0 129712.0 136540.3 136724.0 136920.0 137728.3 1277.4 1302.4 1325.4 1328.4 1333.0 22719.3 23227.9 23303.2 23304.5 23403.5 62901.4 65049.3 66334.0 67028.7 67196.3 80230.2 84473.2 84569.6 85500.0 85804.6 13109.4 13514.7 14257.2 15913.3 16380.5 24901.5 25346.1 25634.1 25815.6 25929.6 20320.5 20495.9 20559.6 20565.4 20752.6 17434.2 17654.6 17975.2 18467.2 18660.3 20653.6 21236.5 21251.7 21270.8 21304.5 15532.4 16181.4 16219.5 16228.4 16262.3 20085.1 20378.8 20403.7 20532.6 20543.7 16:41:59 INFO - PID 11127 | 16:41:59 INFO - PID 11127 | [#3] mootools.html Cycles:180 Average:10527.47 Median:23716.97 stddev:7633.49 (32.2%) stddev-sans-first:7624.48 16:41:59 INFO - PID 11127 | Values: 1456.6 1506.2 1507.6 1529.4 1533.1 16779.7 17448.3 17458.6 17460.7 17487.8 16554.4 18135.1 18141.3 18142.7 18145.4 2866.0 2899.9 2904.6 2909.8 2910.6 2815.9 2817.3 2885.6 2886.0 2918.4 2848.9 2907.2 2924.2 2924.3 2927.0 2738.2 2770.5 2771.2 2774.3 2778.5 2735.6 2737.5 2738.3 2741.7 2751.4 16432.3 16470.7 16593.0 16651.8 16681.3 8272.0 8527.1 8579.9 8621.1 8625.4 5361.2 5561.8 5664.6 5744.5 5774.1 2102.5 2154.1 2171.4 2175.3 2179.1 29607.1 29839.0 29849.0 29858.4 29872.6 7073.4 7250.6 7272.5 7366.9 7429.2 19254.9 19334.6 19361.3 19382.9 19390.9 8435.4 8631.1 8640.2 8644.1 8665.0 7245.9 7401.3 7403.6 7841.9 7912.5 5450.8 5632.1 5651.9 5689.2 5716.3 1494.7 1532.8 1597.4 1612.0 1664.5 1003.6 1005.4 1005.6 1005.9 1026.0 9584.6 9593.5 9734.2 9746.7 9923.8 1050.5 1066.5 1072.1 1082.3 1087.4 5664.9 5699.7 5805.7 5868.5 5959.1 23567.2 23871.5 24580.6 24826.3 24862.1 23866.8 24215.5 24245.4 24293.9 24506.1 12211.0 12504.4 12786.3 12788.4 12800.7 10165.3 10287.5 10298.8 10490.6 10652.3 21185.8 21573.7 21926.8 21999.2 22193.0 21582.5 21588.8 22008.2 22068.4 22087.3 13013.4 13192.7 13199.9 13200.3 13584.5 15576.6 15816.4 15864.2 15876.3 15890.0 12625.9 12645.0 12716.4 12745.6 12811.4 12661.4 12698.6 12973.7 13111.6 13159.9 11078.3 11354.3 11373.0 11380.7 11442.8 8295.1 8383.8 8385.0 8398.6 8449.4 8258.4 8258.8 8264.0 8359.3 8359.9 16:41:59 INFO - PID 11127 | 16:41:59 INFO - PID 11127 | [#4] prototype.html Cycles:180 Average:5927.73 Median:6641.32 stddev:1653.69 (24.9%) stddev-sans-first:1608.19 16:41:59 INFO - PID 11127 | Values: 543.6 553.2 579.3 584.4 587.0 6489.4 6562.9 6695.2 6721.8 6764.2 6631.3 6647.9 6674.6 6698.9 6718.8 5059.3 5264.8 5447.7 5452.6 5486.3 5265.7 5284.3 5289.3 5321.1 5332.1 5217.9 5268.0 5272.2 5282.1 5282.8 5258.6 5259.4 5270.3 5279.2 5280.9 4793.3 4795.6 4796.0 4821.4 4825.9 6443.9 6477.7 6666.9 6729.4 6752.2 5993.9 6137.0 6151.6 6161.0 6161.1 7006.9 7142.5 7144.6 7166.9 7177.5 5250.6 5319.2 5343.8 5354.8 5355.4 6945.9 7225.3 7226.9 7255.3 7352.5 5336.7 5429.4 5434.6 5437.8 5484.4 5456.6 5499.2 5523.9 5557.1 5562.7 6112.9 6129.6 6147.2 6156.9 6167.2 7037.3 7081.6 7119.2 7142.8 7156.3 1890.7 1890.8 1908.1 1946.2 1948.5 1290.3 1323.8 1332.8 1338.2 1350.9 6143.0 6210.8 6241.8 6272.8 6287.8 7049.5 7050.9 7116.7 7156.7 7197.7 6213.3 6271.3 6278.7 6295.9 6299.5 3816.7 3826.9 3842.5 3875.2 3877.3 7107.9 7169.1 7211.4 7219.2 7222.3 7308.1 7368.9 7395.2 7407.7 7511.0 7021.9 7068.2 7072.8 7076.2 7141.3 7143.9 7156.3 7196.7 7228.2 7315.3 7161.4 7227.5 7231.8 7259.9 7263.8 7058.0 7080.3 7104.8 7176.2 7220.2 5445.8 5447.8 5453.0 5460.9 5492.5 6870.4 7083.9 7180.6 7268.1 7288.3 6634.7 6755.9 6820.7 6893.6 6999.6 6860.5 6886.9 6898.0 6925.2 7023.3 6839.4 6881.7 6926.5 6997.0 7011.6 6824.9 6876.2 6883.7 7013.7 7026.8 6744.2 6774.4 6825.3 6858.5 6872.3 16:41:59 INFO - PID 11127 | 16:41:59 INFO - PID 11127 | [#5] yui.html Cycles:180 Average:27150.90 Median:21001.42 stddev:37735.60 (179.7%) stddev-sans-first:37790.29 16:41:59 INFO - PID 11127 | Values: 978.3 987.3 1010.8 1015.6 1021.4 18656.5 19000.3 19421.0 19450.0 20513.8 21990.9 22515.5 22569.3 22606.9 22682.4 1069.9 1110.1 1110.7 1110.8 1111.2 975.6 1100.1 1105.8 1105.8 1106.5 1140.2 1140.5 1141.1 1141.1 1141.2 1141.2 1141.4 1143.3 1143.4 1144.3 841.0 841.0 841.4 843.1 843.6 18329.6 18330.0 18412.2 19784.0 21556.5 22299.9 22723.3 23223.7 23231.0 23258.2 18537.2 18730.3 18845.5 18902.9 19133.6 4032.5 4039.6 4044.0 4047.5 4060.1 138051.0 139989.3 140726.0 141806.0 142943.0 17183.2 17683.6 17851.8 17852.6 17859.2 32489.8 32704.3 33016.5 33509.7 33557.5 9045.0 9194.0 9266.0 9289.7 9316.1 4403.3 4474.7 4489.7 4496.9 4518.0 5980.9 6178.9 6191.5 6259.9 6279.0 1070.9 1107.0 1110.1 1123.4 1125.4 756.8 761.6 777.8 782.4 782.6 12587.9 13041.0 13785.2 14413.1 14471.1 726.5 731.4 735.7 742.1 752.6 5993.5 6031.4 6063.8 6075.5 6213.7 128088.0 129768.0 130769.0 130838.3 137259.3 121435.0 122413.0 123512.4 123514.4 126152.4 105110.5 106158.9 107507.0 109129.0 109334.5 14247.2 14677.2 14715.9 14774.9 15010.6 48682.8 48912.8 49040.5 49522.5 49535.5 63895.0 64654.0 64749.0 66677.0 66951.0 20313.1 20372.0 20720.1 21358.7 21386.8 23273.0 23613.0 23665.2 23721.3 23972.0 21566.4 21727.7 21807.8 22031.8 22058.6 20643.8 21256.1 21293.1 21324.3 21522.2 20746.7 21394.4 21478.0 21541.9 21676.0 13453.7 14318.4 14463.3 14543.6 14617.9 14981.7 15608.4 16002.2 16341.6 16486.9 16:41:59 INFO - PID 11127 | -------- Summary: end -------- 16:41:59 INFO - PID 11127 | 16:42:00 INFO - TEST-INFO | 11127: exit 0 16:42:00 INFO - TEST-OK | dromaeo_css | took 1107947ms 16:42:00 INFO - TEST-START | kraken 16:42:00 INFO - Initialising browser for kraken test... 16:42:00 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:33093/getInfo.html -profile /tmp/tmpcewpj1/profile 16:42:00 INFO - TEST-INFO | started process 11497 (/builds/slave/test/build/application/firefox/firefox http://localhost:33093/getInfo.html) 16:42:05 INFO - TEST-INFO | 11497: exit 0 16:42:05 INFO - Browser initialized. 16:42:05 INFO - Running cycle 1/1 for kraken test... 16:42:05 INFO - Using env: {'DISPLAY': ':0', 16:42:05 INFO - 'HOME': '/home/cltbld', 16:42:05 INFO - 'JSGC_DISABLE_POISONING': '1', 16:42:05 INFO - 'LANG': 'en_US.UTF-8', 16:42:05 INFO - 'LANGUAGE': 'en_US:en', 16:42:05 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 16:42:05 INFO - 'LOGNAME': 'cltbld', 16:42:05 INFO - 'MAIL': '/var/mail/cltbld', 16:42:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:42:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:42:05 INFO - 'MOZ_CRASHREPORTER': '1', 16:42:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:42:05 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 16:42:05 INFO - 'MOZ_NO_REMOTE': '1', 16:42:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:42:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:42:05 INFO - 'NO_EM_RESTART': '1', 16:42:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:42:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:42:05 INFO - 'PWD': '/builds/slave/test', 16:42:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:42:05 INFO - 'RUST_BACKTRACE': 'full', 16:42:05 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:42:05 INFO - 'SHELL': '/bin/bash', 16:42:05 INFO - 'SHLVL': '1', 16:42:05 INFO - 'TERM': 'linux', 16:42:05 INFO - 'TMOUT': '86400', 16:42:05 INFO - 'USER': 'cltbld', 16:42:05 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1504653743.516103-1680718200', 16:42:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:42:05 INFO - '_': '/tools/buildbot/bin/python'} 16:42:05 INFO - TEST-INFO | started process 11682 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcewpj1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:42:06 INFO - PID 11682 | 16:42:06 INFO - PID 11682 | (/builds/slave/test/build/application/firefox/firefox:11736): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:42:06 INFO - PID 11682 | 16:42:16 INFO - PID 11682 | RSS: Main: 163201024 16:42:16 INFO - PID 11682 | 16:42:18 INFO - PID 11682 | Cycle 1(1): loaded http://localhost:33093/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33093/tests/kraken/driver.html?testName=audio-beat-detection) 16:42:19 INFO - PID 11682 | RSS: Main: 168968192 16:42:19 INFO - PID 11682 | 16:42:22 INFO - PID 11682 | Cycle 1(1): loaded http://localhost:33093/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33093/tests/kraken/driver.html?testName=audio-dft) 16:42:22 INFO - PID 11682 | RSS: Main: 173633536 16:42:22 INFO - PID 11682 | 16:42:25 INFO - PID 11682 | Cycle 1(1): loaded http://localhost:33093/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33093/tests/kraken/driver.html?testName=audio-fft) 16:42:26 INFO - PID 11682 | RSS: Main: 166305792 16:42:26 INFO - PID 11682 | 16:42:28 INFO - PID 11682 | Cycle 1(1): loaded http://localhost:33093/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33093/tests/kraken/driver.html?testName=audio-oscillator) 16:42:29 INFO - PID 11682 | RSS: Main: 167735296 16:42:29 INFO - PID 11682 | 16:42:31 INFO - PID 11682 | Cycle 1(1): loaded http://localhost:33093/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33093/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:42:31 INFO - PID 11682 | RSS: Main: 167731200 16:42:31 INFO - PID 11682 | 16:42:34 INFO - PID 11682 | Cycle 1(1): loaded http://localhost:33093/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33093/tests/kraken/driver.html?testName=imaging-darkroom) 16:42:35 INFO - PID 11682 | RSS: Main: 167464960 16:42:35 INFO - PID 11682 | 16:42:38 INFO - PID 11682 | Cycle 1(1): loaded http://localhost:33093/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33093/tests/kraken/driver.html?testName=imaging-desaturate) 16:42:39 INFO - PID 11682 | RSS: Main: 168833024 16:42:39 INFO - PID 11682 | 16:42:42 INFO - PID 11682 | Cycle 1(1): loaded http://localhost:33093/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33093/tests/kraken/driver.html?testName=json-parse-financial) 16:42:42 INFO - PID 11682 | RSS: Main: 169398272 16:42:42 INFO - PID 11682 | 16:42:44 INFO - PID 11682 | Cycle 1(1): loaded http://localhost:33093/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33093/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:42:45 INFO - PID 11682 | RSS: Main: 169725952 16:42:45 INFO - PID 11682 | 16:42:46 INFO - PID 11682 | Cycle 1(1): loaded http://localhost:33093/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33093/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:42:47 INFO - PID 11682 | RSS: Main: 169869312 16:42:47 INFO - PID 11682 | 16:42:49 INFO - PID 11682 | Cycle 1(1): loaded http://localhost:33093/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33093/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:42:49 INFO - PID 11682 | RSS: Main: 166469632 16:42:49 INFO - PID 11682 | 16:42:52 INFO - PID 11682 | Cycle 1(1): loaded http://localhost:33093/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33093/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:42:53 INFO - PID 11682 | RSS: Main: 166203392 16:42:53 INFO - PID 11682 | 16:42:55 INFO - PID 11682 | Cycle 1(1): loaded http://localhost:33093/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33093/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:42:56 INFO - PID 11682 | RSS: Main: 166461440 16:42:56 INFO - PID 11682 | 16:42:58 INFO - PID 11682 | Cycle 1(1): loaded http://localhost:33093/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33093/tests/kraken/driver.html?testName=ai-astar) 16:42:58 INFO - PID 11682 | RSS: Main: 168554496 16:42:58 INFO - PID 11682 | 16:42:58 INFO - PID 11682 | __start_tp_report 16:42:58 INFO - PID 11682 | _x_x_mozilla_page_load 16:42:58 INFO - PID 11682 | _x_x_mozilla_page_load_details 16:42:58 INFO - PID 11682 | |i|pagename|runs| 16:42:58 INFO - PID 11682 | |0;ai-astar;96;113;98;105;106;106;107;97;105;107 16:42:58 INFO - PID 11682 | |1;audio-beat-detection;146;112;145;163;114;136;139;112;165;113 16:42:58 INFO - PID 11682 | |2;audio-dft;163;162;162;161;161;161;163;162;160;164 16:42:58 INFO - PID 11682 | |3;audio-fft;73;73;72;172;74;73;73;73;154;74 16:42:58 INFO - PID 11682 | |4;audio-oscillator;78;79;124;79;79;78;121;78;77;125 16:42:58 INFO - PID 11682 | |5;imaging-gaussian-blur;114;115;114;114;114;114;114;114;113;113 16:42:58 INFO - PID 11682 | |6;imaging-darkroom;152;150;152;155;149;150;150;149;150;150 16:42:58 INFO - PID 11682 | |7;imaging-desaturate;95;96;94;94;93;94;94;94;95;95 16:42:58 INFO - PID 11682 | |8;json-parse-financial;45;58;48;44;46;46;44;44;44;46 16:42:58 INFO - PID 11682 | |9;json-stringify-tinderbox;45;46;46;47;46;45;46;46;47;46 16:42:58 INFO - PID 11682 | |10;stanford-crypto-aes;71;79;72;72;78;71;73;73;72;70 16:42:58 INFO - PID 11682 | |11;stanford-crypto-ccm;112;118;115;119;120;112;109;118;110;157 16:42:58 INFO - PID 11682 | |12;stanford-crypto-pbkdf2;156;158;158;165;153;163;152;162;155;151 16:42:58 INFO - PID 11682 | |13;stanford-crypto-sha256-iterative;60;65;58;59;62;58;63;60;58;61 16:42:58 INFO - PID 11682 | __end_tp_report 16:42:58 INFO - PID 11682 | __start_cc_report 16:42:58 INFO - PID 11682 | _x_x_mozilla_cycle_collect,908 16:42:58 INFO - PID 11682 | __end_cc_report 16:42:58 INFO - PID 11682 | __startTimestamp1504654978488__endTimestamp 16:42:58 INFO - PID 11682 | 16:42:58 INFO - PID 11682 | ------- Summary: start ------- 16:42:58 INFO - PID 11682 | Number of tests: 14 16:42:58 INFO - PID 11682 | 16:42:58 INFO - PID 11682 | [#0] ai-astar Cycles:10 Average:104.00 Median:110.00 stddev:5.35 (4.9%) stddev-sans-first:4.83 16:42:58 INFO - PID 11682 | Values: 96.0 113.0 98.0 105.0 106.0 106.0 107.0 97.0 105.0 107.0 16:42:58 INFO - PID 11682 | 16:42:58 INFO - PID 11682 | [#1] audio-beat-detection Cycles:10 Average:134.50 Median:142.00 stddev:20.82 (14.7%) stddev-sans-first:21.67 16:42:58 INFO - PID 11682 | Values: 146.0 112.0 145.0 163.0 114.0 136.0 139.0 112.0 165.0 113.0 16:42:58 INFO - PID 11682 | 16:42:58 INFO - PID 11682 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:1.20 (0.7%) stddev-sans-first:1.20 16:42:58 INFO - PID 11682 | Values: 163.0 162.0 162.0 161.0 161.0 161.0 163.0 162.0 160.0 164.0 16:42:58 INFO - PID 11682 | 16:42:58 INFO - PID 11682 | [#3] audio-fft Cycles:10 Average:91.10 Median:73.00 stddev:38.14 (52.2%) stddev-sans-first:39.88 16:42:58 INFO - PID 11682 | Values: 73.0 73.0 72.0 172.0 74.0 73.0 73.0 73.0 154.0 74.0 16:42:58 INFO - PID 11682 | 16:42:58 INFO - PID 11682 | [#4] audio-oscillator Cycles:10 Average:91.80 Median:78.00 stddev:21.79 (27.9%) stddev-sans-first:22.53 16:42:58 INFO - PID 11682 | Values: 78.0 79.0 124.0 79.0 79.0 78.0 121.0 78.0 77.0 125.0 16:42:58 INFO - PID 11682 | 16:42:58 INFO - PID 11682 | [#5] imaging-gaussian-blur Cycles:10 Average:113.90 Median:114.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 16:42:58 INFO - PID 11682 | Values: 114.0 115.0 114.0 114.0 114.0 114.0 114.0 114.0 113.0 113.0 16:42:58 INFO - PID 11682 | 16:42:58 INFO - PID 11682 | [#6] imaging-darkroom Cycles:10 Average:150.70 Median:150.00 stddev:1.83 (1.2%) stddev-sans-first:1.88 16:42:58 INFO - PID 11682 | Values: 152.0 150.0 152.0 155.0 149.0 150.0 150.0 149.0 150.0 150.0 16:42:58 INFO - PID 11682 | 16:42:58 INFO - PID 11682 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.84 (0.9%) stddev-sans-first:0.87 16:42:58 INFO - PID 11682 | Values: 95.0 96.0 94.0 94.0 93.0 94.0 94.0 94.0 95.0 95.0 16:42:58 INFO - PID 11682 | 16:42:58 INFO - PID 11682 | [#8] json-parse-financial Cycles:10 Average:46.50 Median:46.00 stddev:4.25 (9.2%) stddev-sans-first:4.47 16:42:58 INFO - PID 11682 | Values: 45.0 58.0 48.0 44.0 46.0 46.0 44.0 44.0 44.0 46.0 16:42:58 INFO - PID 11682 | 16:42:58 INFO - PID 11682 | [#9] json-stringify-tinderbox Cycles:10 Average:46.00 Median:46.00 stddev:0.67 (1.4%) stddev-sans-first:0.60 16:42:58 INFO - PID 11682 | Values: 45.0 46.0 46.0 47.0 46.0 45.0 46.0 46.0 47.0 46.0 16:42:58 INFO - PID 11682 | 16:42:58 INFO - PID 11682 | [#10] stanford-crypto-aes Cycles:10 Average:73.10 Median:72.50 stddev:3.00 (4.1%) stddev-sans-first:3.08 16:42:58 INFO - PID 11682 | Values: 71.0 79.0 72.0 72.0 78.0 71.0 73.0 73.0 72.0 70.0 16:42:58 INFO - PID 11682 | 16:42:58 INFO - PID 11682 | [#11] stanford-crypto-ccm Cycles:10 Average:119.00 Median:118.00 stddev:13.91 (11.8%) stddev-sans-first:14.52 16:42:58 INFO - PID 11682 | Values: 112.0 118.0 115.0 119.0 120.0 112.0 109.0 118.0 110.0 157.0 16:42:58 INFO - PID 11682 | 16:42:58 INFO - PID 11682 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.30 Median:158.00 stddev:4.81 (3.0%) stddev-sans-first:5.08 16:42:58 INFO - PID 11682 | Values: 156.0 158.0 158.0 165.0 153.0 163.0 152.0 162.0 155.0 151.0 16:42:58 INFO - PID 11682 | 16:42:58 INFO - PID 11682 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.40 Median:60.50 stddev:2.37 (3.9%) stddev-sans-first:2.51 16:42:58 INFO - PID 11682 | Values: 60.0 65.0 58.0 59.0 62.0 58.0 63.0 60.0 58.0 61.0 16:42:58 INFO - PID 11682 | -------- Summary: end -------- 16:42:58 INFO - PID 11682 | 16:42:58 INFO - PID 11682 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 16:42:59 INFO - TEST-INFO | 11682: exit 0 16:42:59 INFO - TEST-OK | kraken | took 58976ms 16:42:59 INFO - SUITE-END | took 1166s 16:42:59 INFO - Completed test suite (00:19:27) 16:42:59 INFO - javascript benchmark 16:42:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9339.565099845659, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3875.709321800864, 3920.7451515651464, 3925.5485619153806, 3927.0, 3941.2117576484693, 6542.574732642375, 6661.433778128859, 6673.332666733324, 6678.232003319614, 6729.730810767575, 6669.933300666992, 6748.763793267224, 6753.864922701543, 6788.490863185269, 6809.761658341959, 6005.339412664614, 6009.969950150243, 6035.758569657209, 6080.969595152018, 6083.847903802418, 5971.044632858721, 6006.249218847644, 6042.244719410074, 6059.909101363483, 6130.785422510213, 6045.848853778669, 6140.2324709411105, 6143.754249830024, 6144.5698801083945, 6157.938420615781, 6045.939540604581, 6064.332923378425, 6138.355472675349, 6171.444569988677, 6176.702892392558, 6012.5791194616395, 6033.48715359195, 6036.879262414727, 6102.511799056065, 6119.632822030692, 6688.4649228061635, 6773.796786096425, 6781.762638307685, 6786.083878676414, 6857.897131543031, 7276.96361518189, 7287.9271207287775, 7311.524750891175, 7392.039034925479, 7406.666699998513, 7254.746083887038, 7313.378362839165, 7354.595497247649, 7362.0, 7399.963000185018, 6780.0, 6855.828604284883, 6876.209235937831, 6877.140357455318, 6883.105196324445, 7456.4780465367985, 7482.4388170887405, 7536.924630753732, 7554.2823431773895, 7574.394048476109, 7094.53885497441, 7138.39323657495, 7145.999560061596, 7168.928310716826, 7183.49715519919, 7130.572165670076, 7183.245759195209, 7215.783526494213, 7219.169795473587, 7221.061262035902, 7182.066331376992, 7239.384652304508, 7305.525140865827, 7365.52124111931, 7384.150822655356, 7293.721338109685, 7352.007478990375, 7392.1499027611435, 7392.371648409945, 7398.889016664754, 6152.415520525543, 6161.44546990773, 6236.594621349598, 6243.125962365272, 6256.5307601930035, 5295.4439783822145, 5345.251664766858, 5370.03339398912, 5391.16436952273, 5414.864628384243, 6262.718177682015, 6283.340249273851, 6295.338989406138, 6302.527310451735, 6321.1782468278825, 7180.8922866157045, 7189.7483588074165, 7282.089738782653, 7290.270972902667, 7301.853962920712, 6244.094606282064, 6268.529860260407, 6290.811275661737, 6369.426751592379, 6369.649669268235, 6551.344865513411, 6630.9668451657435, 6641.203055633355, 6655.134832471747, 6706.631135287606, 7160.749373771997, 7224.819379515554, 7261.0, 7265.128184617774, 7274.672639731225, 7190.568565886064, 7272.05463289769, 7282.4902256841515, 7346.77959661211, 7374.188839227681, 6960.129983752031, 7076.469264805057, 7115.53749006313, 7190.496665233383, 7257.818554536178, 7201.603911784902, 7226.819329516594, 7236.0231368766645, 7257.092863392076, 7274.636268186676, 7175.641217939186, 7292.41660667156, 7345.6694448751, 7375.483716139819, 7390.29792169743, 6893.965530172317, 6984.092068031124, 6994.370506654425, 7076.716931322895, 7080.114985626797, 6828.283030281749, 6977.825554361181, 7023.648817559204, 7031.332023457763, 7093.184283807428, 6993.615351155735, 6998.545094568837, 7014.158301003912, 7095.290470952863, 7103.893441598483, 6905.689243983932, 6907.516473846783, 7016.087908571853, 7017.543859649107, 7121.465890058163, 6816.625085620339, 6823.454123670193, 6828.829279268058, 6832.0435139081565, 6861.073755043005], "value": 6671.706559412856, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [885.8804061451706, 938.2259635800463, 966.5505539923934, 980.6665733650561, 981.9901800981988, 42177.156456870885, 43370.34944475835, 43454.34818477726, 43479.56520434795, 43638.563614363884, 40179.0, 40284.19431611366, 40328.59671403292, 40569.797151014274, 40655.59344406555, 7314.817129571763, 7407.592582407965, 7415.147258065311, 7418.591977441239, 7433.145188303361, 7269.273072692741, 7357.521761085539, 7360.815979600499, 7363.889541656879, 7371.705131794722, 7338.853222935538, 7987.241212084843, 8163.346932245406, 8163.95918020409, 8172.550509721963, 8041.0, 8072.959635201845, 8084.353251739905, 8088.312493438036, 8111.513309201467, 7702.653380597886, 7864.68541258349, 7866.646000929972, 7972.242636949481, 8087.878681819778, 38930.0, 39218.41172382417, 39226.0, 39254.214915701814, 39358.40962385567, 3666.7066634669427, 3707.1473561080834, 3708.2768860072297, 3710.07248187953, 3716.8141592920515, 32592.348153037045, 32630.673693263, 32695.6730432695, 32740.836295818608, 32750.508742368882, 5385.7576409061685, 5393.460653934614, 5408.486193811582, 5413.512783849433, 5517.586181036439, 204166.0, 204338.0, 205350.0, 211728.0, 219853.0, 52746.0, 53022.46977530175, 53196.46803531915, 53218.73390633022, 53221.733891330296, 55114.72442637761, 55129.0, 55139.44860551423, 55420.72289638607, 55425.445745542835, 14608.269586520631, 14639.268036598127, 14661.92669036648, 14758.63103422423, 14886.106833589804, 11916.404179790976, 11924.880751192377, 11925.88074119265, 11935.104867135, 11939.582114625946, 15224.847751522564, 15280.694386112216, 15311.234438278041, 15352.769708454382, 15458.768118478232, 5673.631213971161, 5779.595428319977, 5882.911566393954, 5888.617239879394, 5934.7922822701, 1082.7293176705823, 1091.2088735666737, 1093.2456604942565, 1097.8023955687893, 1101.5758932810925, 25857.74142258591, 25876.74123258781, 25893.223203303933, 26103.869480652476, 26245.606315905276, 1157.9189456737947, 1167.8890505401973, 1178.8113901775846, 1191.142377488207, 1198.8681245063035, 13052.934735326262, 13208.33958302081, 13423.26172060546, 13558.93220533891, 13603.523876664269, 288994.0, 296533.0, 296722.0, 296897.0, 297417.0, 59548.70225648844, 60005.0, 60169.39830601638, 60663.39336606577, 60736.39263607308, 1486.2642991718951, 1506.540505145941, 1511.5767585076196, 1521.2241756703938, 1528.2206074901658, 30590.0, 30733.846330769098, 31054.950984801046, 31079.0, 31767.841160794047, 41537.58462415458, 41726.0, 41727.37408938929, 41909.79045104877, 42061.789691052574, 256153.0, 256158.0, 258001.0, 258149.0, 258253.0, 36794.632053680194, 37301.6269837309, 39532.60467395404, 39627.80186099051, 39717.80141099276, 48137.51862481471, 49469.257961131334, 49688.503114968385, 50085.499145008085, 50261.74869125631, 35487.467687984186, 35935.281294373446, 36022.0, 36161.63838361688, 36800.63199367972, 35588.0, 36120.638793611724, 36343.0, 36555.81722091373, 36797.81601092085, 41567.37648935208, 42025.78987105045, 42292.0, 42355.0, 42417.787911060244, 35026.0, 35134.12164695903, 35168.472472912414, 35534.822325888206, 35665.0, 25520.48959020772, 26650.0, 26820.195394138205, 27109.72890271151, 27485.17544473669], "value": 18547.082572208874, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [594.1207013619843, 597.9073243647231, 604.3744724210437, 611.4099893602674, 631.3591704420013, 22144.114235430563, 22676.65985010224, 23463.0, 23488.765112348872, 23500.412489687766, 26877.193684189457, 27051.32371690709, 27207.727922720765, 27243.727562724365, 27247.182584522445, 6464.741410343592, 6616.735330586795, 6619.834504137387, 6620.6358650274215, 6622.0, 6084.574079814415, 6583.440407565363, 6700.932990670104, 6707.1616047994, 6710.5302628816, 6666.233383160926, 6666.699998500055, 6669.0, 6671.432928201109, 6678.632675202862, 6644.0, 6645.435138013275, 6649.60102393858, 6654.933450665504, 6656.600603963753, 6218.564700470969, 6230.470410015154, 6246.531510136758, 6260.186175797163, 6262.655553944532, 29492.410151796845, 30122.84938575315, 30140.24649383783, 31425.37149257002, 31586.0, 2200.0759680934048, 2242.5627002734473, 2247.101159536199, 2247.9662805057937, 2248.4266512039326, 19560.217591296332, 20353.287634932854, 20812.0, 20812.58374832495, 20830.166793328248, 2446.425090103824, 2462.052109937669, 2513.6857892763405, 2522.0668352709613, 2524.684414448194, 151314.24342878326, 154791.0, 156354.43645563512, 157062.0, 157957.0, 15836.841631583537, 16099.517014489584, 16197.190140492929, 16380.26288817006, 17080.48758537246, 26118.216453506426, 26142.477150456885, 26246.86876565605, 26277.73722262791, 26286.86856565705, 10124.595016199417, 10251.794964100676, 10284.897151028394, 10314.432706201082, 10342.793144137075, 7881.408894332948, 9018.0, 9086.500727379907, 9101.726948191565, 9180.31147663928, 8338.62476188573, 9743.415395076318, 9834.803303934024, 10170.237232207613, 10184.134348580454, 2710.5256580098403, 2788.344738986337, 2811.8594070296404, 2844.8293102413922, 2880.222339968197, 1056.4612047855649, 1069.7165251208437, 1070.7739638114315, 1076.042322333124, 1082.5886163257912, 21849.126034958423, 22006.559868802535, 22014.44963875916, 22041.779582204294, 22224.222152224593, 1078.6494389323502, 1128.5880653561555, 1128.9774204515863, 1132.7904337697553, 1151.8157094864948, 11744.354060526754, 12081.75836483283, 14161.85838141626, 14436.566902992927, 15490.225488725519, 645109.0, 660919.0, 668410.0, 677783.0, 694479.0, 129712.0, 136540.31729841288, 136724.0, 136920.0, 137728.31135844457, 1277.4187744576195, 1302.433441452971, 1325.3903204525834, 1328.4022190014532, 1333.046871486872, 22719.318420447413, 23227.88386058059, 23303.18438854632, 23304.533909322057, 23403.53192936166, 62901.37098629138, 65049.34950650622, 66334.0, 67028.6648566754, 67196.328036719, 80230.19769802461, 84473.15526844653, 84569.57715211631, 85500.0, 85804.57097714471, 13109.410076546768, 13514.662133446742, 14257.215853128178, 15913.283902224197, 16380.508584742476, 24901.50196996086, 25346.1128860489, 25634.102806401686, 25815.612765808903, 25929.6110558338, 20320.491987699836, 20495.897520512302, 20559.588808223452, 20565.38303850887, 20752.58494830125, 17434.21546030406, 17654.587632989074, 17975.191116400056, 18467.16897739578, 18660.34688785886, 20653.58692826165, 21236.469088272916, 21251.68122478195, 21270.78729212688, 21304.467388315417, 15532.378704851679, 16181.4336498222, 16219.51341459758, 16228.350865965229, 16262.3495060201, 20085.09617067265, 20378.79621203769, 20403.693944590545, 20532.589348212652, 20543.691844622044], "value": 13031.344091119961, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1456.5994351553322, 1506.1866592040299, 1507.640542550907, 1529.395888623993, 1533.1491022482521, 16779.664406711872, 17448.3020679173, 17458.56353591161, 17460.650786984268, 17487.825121748778, 16554.420595279167, 18135.093245337714, 18141.27434902602, 18142.727859082126, 18145.364912228073, 2866.011226126983, 2899.898503552376, 2904.5933569300314, 2909.796314258003, 2910.5738188287796, 2815.9014434494798, 2817.2534278416238, 2885.552739325408, 2886.0, 2918.3871387008753, 2848.886044558215, 2907.215051935976, 2924.1519959211805, 2924.312786495172, 2927.0340787540063, 2738.192233291184, 2770.5290100682932, 2771.1686494051705, 2774.3064233941413, 2778.4859800936792, 2735.617013618095, 2737.5346191147355, 2738.274357295318, 2741.7258274172623, 2751.408447183865, 16432.342706291733, 16470.6705865882, 16593.0, 16651.75022374653, 16681.332746690117, 8271.95864020682, 8527.104654011302, 8579.871301930476, 8621.05168431472, 8625.353098517637, 5361.195820626898, 5561.805336813192, 5664.631798933056, 5744.511716504102, 5774.076147816371, 2102.4638717127186, 2154.149111101122, 2171.356823979583, 2175.3365223606793, 2179.063002908749, 29607.111786646434, 29839.0, 29849.0, 29858.40283194346, 29872.551911721122, 7073.398761105261, 7250.564966102051, 7272.454565907472, 7366.889496657554, 7429.182789893108, 19254.903725481283, 19334.613307733765, 19361.322353717835, 19382.903085484766, 19390.903045484683, 8435.409521333571, 8631.050584435707, 8640.222379985706, 8644.092370301154, 8664.956675216583, 7245.8550828983125, 7401.259874012556, 7403.555786652818, 7841.921580784233, 7912.525248484994, 5450.781968721207, 5632.070708333161, 5651.9152212716845, 5689.175069614966, 5716.28546431696, 1494.6562290673205, 1532.8237252715858, 1597.4089586852938, 1611.9516414507584, 1664.4507312586818, 1003.6487229469773, 1005.3615953869199, 1005.5726316315537, 1005.9144972677404, 1025.9640912568025, 9584.568694408768, 9593.520323983774, 9734.221262299, 9746.707598772047, 9923.801523969625, 1050.495762034228, 1066.4696161008976, 1072.1369297715257, 1082.3127314155568, 1087.3856271206744, 5664.8867022659315, 5699.686517241592, 5805.6806875621405, 5868.471837534642, 5959.0763431668165, 23567.17514886971, 23871.522569548513, 24580.631290530655, 24826.255212343658, 24862.12982545602, 23866.761332386453, 24215.51568968646, 24245.393865153514, 24293.878530607235, 24506.142285019938, 12211.0, 12504.437300321326, 12786.29675367845, 12788.36058197105, 12800.679983000313, 10165.288429809842, 10287.485625718833, 10298.794024119625, 10490.580376784843, 10652.307600005975, 21185.788142119, 21573.676394853777, 21926.780732192474, 21999.23002694898, 22193.0, 21582.460438488535, 21588.784112159305, 22008.229711960004, 22068.448288792908, 22087.33737987863, 13013.414396351998, 13192.73614527685, 13199.934000329937, 13200.339983001004, 13584.456621735415, 15576.610584735019, 15816.446424375092, 15864.206789660702, 15876.285567149274, 15890.046597204204, 12625.873741262838, 12645.0, 12716.427760750603, 12745.61763147107, 12811.423485942969, 12661.366931653565, 12698.619041428772, 12973.675658108245, 13111.60665180046, 13159.934200328937, 11078.335299882034, 11354.26197297173, 11373.0, 11380.658580242605, 11442.82835757481, 8295.12901145371, 8383.790405239917, 8385.0, 8398.580070996304, 8449.366297527833, 8258.425846570932, 8258.793530161794, 8263.9586802068, 8359.289460395934, 8359.874601881098], "value": 7419.351631817884, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [543.5570010441489, 553.1785298831235, 579.2701196492418, 584.4009889862891, 586.9559783016272, 6489.351064893508, 6562.9015564766505, 6695.163104611924, 6721.764738234163, 6764.241297262723, 6631.303713110126, 6647.900281495781, 6674.566153200039, 6698.933010669892, 6718.764843230488, 5059.3422855028975, 5264.763085661154, 5447.700376479283, 5452.59105567082, 5486.341639003325, 5265.684058956455, 5284.25619545549, 5289.285946397225, 5321.095413779647, 5332.093544097494, 5217.947820521803, 5267.973660131694, 5272.202295910722, 5282.144034854558, 5282.788688452457, 5258.6318957672975, 5259.447757985433, 5270.341207349063, 5279.155335146377, 5280.894382112337, 4793.257045158006, 4795.592374648159, 4795.976020119877, 4821.421429428456, 4825.855224343275, 6443.935560644427, 6477.74089036438, 6666.899996500057, 6729.360710732472, 6752.189737231514, 5993.9400605993815, 6136.96931515344, 6151.5551291277025, 6160.9668809292825, 6161.106639537242, 7006.859862802716, 7142.535735177197, 7144.642767861586, 7166.892496612555, 7177.49757516974, 5250.553702935255, 5319.23399832089, 5343.839684809462, 5354.839354819362, 5355.410904800468, 6945.9233818758175, 7225.313595208447, 7226.855462890765, 7255.2744725527555, 7352.522086064442, 5336.679799211982, 5429.4299098594865, 5434.565234781208, 5437.8368648940595, 5484.424135465799, 5456.645318054314, 5499.202615620713, 5523.917141242885, 5557.110862262019, 5562.666240025612, 6112.938870611237, 6129.601575897553, 6147.170132032118, 6156.938430615636, 6167.167432396569, 7037.2962703730245, 7081.610511421921, 7119.21688614252, 7142.821429464305, 7156.320149585781, 1890.650229707481, 1890.8392786613017, 1908.084119622589, 1946.2094872717134, 1948.5420926082359, 1290.283892439705, 1323.7617228898891, 1332.8067430222757, 1338.1903948111253, 1350.8514063453013, 6142.969285153635, 6210.7515699371515, 6241.843953901189, 6272.776808522385, 6287.779927702509, 7049.4712896532965, 7050.894236586353, 7116.679749411289, 7156.677949492286, 7197.676104575202, 6213.347598502182, 6271.30333956394, 6278.748850045947, 6295.937040629535, 6299.464545513591, 3816.732828701964, 3826.942595861064, 3842.51968503937, 3875.186210895687, 3877.3408520551575, 7107.92892071083, 7169.100188450065, 7211.3870321023305, 7219.205887352387, 7222.277772222736, 7308.123025237006, 7368.852622947511, 7395.186529481753, 7407.6666550005375, 7511.0, 7021.89467157993, 7068.151821781419, 7072.823179420556, 7076.186238582629, 7141.250168732208, 7143.85712285741, 7156.284371562802, 7196.748113815991, 7228.168760592599, 7315.341619254293, 7161.39128174111, 7227.494075414881, 7231.819204519929, 7259.9274007261365, 7263.818404539928, 7058.023753349071, 7080.2919708028785, 7104.751333703295, 7176.246494118252, 7220.169680486812, 5445.83662490126, 5447.782088716565, 5453.04571699943, 5460.918086228789, 5492.47821456961, 6870.416014638811, 7083.929160708327, 7180.5691658500655, 7268.0914885639295, 7288.344049035612, 6634.734610615521, 6755.946432140676, 6820.727170913108, 6893.620850853051, 6999.580025198505, 6860.451163906776, 6886.8622627546165, 6898.0, 6925.238223795278, 7023.262557431396, 6839.418649414855, 6881.724731010703, 6926.549774264657, 6996.965015174892, 7011.614361210182, 6824.93175068243, 6876.209235937931, 6883.657686751236, 7013.684384202621, 7026.781298550717, 6744.22441419243, 6774.390304872585, 6825.317468253135, 6858.536439098223, 6872.312768723088], "value": 5446.357503569008, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [978.2614126334616, 987.2644879564725, 1010.7978404319138, 1015.6496008876937, 1021.3565453764128, 18656.533586660342, 19000.334988275412, 19420.99999999998, 19450.027498625084, 20513.794862051374, 21990.89004554975, 22515.54968900621, 22569.322920312377, 22606.88696556519, 22682.432939176528, 1069.850220969063, 1110.0897264243324, 1110.7278716714377, 1110.7556337605754, 1111.1943840715458, 975.6390135649784, 1100.136392931549, 1105.7898999190168, 1105.8341248812662, 1106.4744246482937, 1140.1676775953558, 1140.4696815980567, 1141.1099342512812, 1141.1270378160673, 1141.2239677019622, 1141.2467771270963, 1141.4007645985882, 1143.3482914738602, 1143.394001179368, 1144.347721798575, 840.9621567029499, 840.9873851892227, 841.4194205997842, 843.1442086282428, 843.5739951324604, 18329.633407331778, 18330.0, 18412.171452284547, 19784.0, 21556.461088472755, 22299.888500557394, 22723.318300451014, 23223.651645225335, 23231.0, 23258.185963491367, 18537.165827537658, 18730.344437944743, 18845.528861778428, 18902.905485472624, 19133.61732765337, 4032.5160980682213, 4039.5758445363404, 4043.9797801010805, 4047.534533528623, 4060.1067765091634, 138051.0, 139989.3000535001, 140726.0, 141806.0, 142943.0, 17183.226754796066, 17683.646327073642, 17851.821481785017, 17852.55368615795, 17859.196336164903, 32489.837550812095, 32704.345913081605, 33016.50475242873, 33509.664903350655, 33557.49663755046, 9045.0, 9194.0, 9266.0, 9289.72130836076, 9316.068393160765, 4403.2734598791485, 4474.731516109044, 4489.73061616304, 4496.887577810516, 4518.0, 5980.880382392328, 6178.907316390258, 6191.473724733358, 6259.937400626027, 6278.968605156945, 1070.9410982396043, 1107.0479387726548, 1110.0564520157964, 1123.3540714089431, 1125.358545629, 756.76162008967, 761.5773245848608, 777.782220978127, 782.440555003164, 782.6243403166512, 12587.93706031464, 13041.0, 13785.241811700253, 14413.13521188732, 14471.059381140192, 726.5422783646269, 731.3929438565978, 735.7057177129191, 742.0798210219289, 752.6124046116255, 5993.460588547052, 6031.366706495843, 6063.787767428119, 6075.513958883279, 6213.726186131922, 128088.0, 129768.0, 130769.0, 130838.34580827034, 137259.31370343085, 121435.0, 122413.0, 123512.38243808903, 123514.38242808728, 126152.36923815322, 105110.47444762728, 106158.93841061645, 107507.0, 109129.0, 109334.45332773286, 14247.21640309793, 14677.192754398611, 14715.926420368258, 14774.852251477778, 15010.624734381729, 48682.75658621684, 48912.75543622259, 49040.5095949036, 49522.50477495179, 49535.504644953086, 63895.0, 64654.0, 64749.0, 66677.0, 66951.0, 20313.085911133738, 20372.0, 20720.067596957873, 21358.679619805403, 21386.786132139103, 23273.0, 23613.0, 23665.171718989754, 23721.288361349187, 23972.0, 21566.353009409115, 21727.674084889055, 21807.78192218121, 22031.779682202974, 22058.558828823654, 20643.793562064187, 21256.149754009668, 21293.148274068863, 21324.253651122137, 21522.246721364678, 20746.688799667714, 21394.35816925495, 21478.0, 21541.892290538446, 21676.0, 13453.663658408617, 14318.355673994487, 14463.349149288097, 14543.563693089225, 14617.853821462075, 14981.700365992838, 15608.375664973273, 16002.19989000522, 16341.591460213589, 16486.917565412095], "value": 10185.030217261941, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1444.5999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 113.0, 98.0, 105.0, 106.0, 106.0, 107.0, 97.0, 105.0, 107.0], "value": 104.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 112.0, 145.0, 163.0, 114.0, 136.0, 139.0, 112.0, 165.0, 113.0], "value": 134.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 162.0, 161.0, 161.0, 161.0, 163.0, 162.0, 160.0, 164.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 72.0, 172.0, 74.0, 73.0, 73.0, 73.0, 154.0, 74.0], "value": 91.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 124.0, 79.0, 79.0, 78.0, 121.0, 78.0, 77.0, 125.0], "value": 91.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 113.0, 113.0], "value": 113.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 150.0, 152.0, 155.0, 149.0, 150.0, 150.0, 149.0, 150.0, 150.0], "value": 150.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 94.0, 94.0, 93.0, 94.0, 94.0, 94.0, 95.0, 95.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [45.0, 58.0, 48.0, 44.0, 46.0, 46.0, 44.0, 44.0, 44.0, 46.0], "value": 46.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [45.0, 46.0, 46.0, 47.0, 46.0, 45.0, 46.0, 46.0, 47.0, 46.0], "value": 46.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 79.0, 72.0, 72.0, 78.0, 71.0, 73.0, 73.0, 72.0, 70.0], "value": 73.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 118.0, 115.0, 119.0, 120.0, 112.0, 109.0, 118.0, 110.0, 157.0], "value": 119.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 158.0, 158.0, 165.0, 153.0, 163.0, 152.0, 162.0, 155.0, 151.0], "value": 157.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 65.0, 58.0, 59.0, 62.0, 58.0, 63.0, 60.0, 58.0, 61.0], "value": 60.4, "unit": "score"}]}]} 16:42:59 INFO - Return code: 0 16:42:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:42:59 INFO - # TBPL SUCCESS # 16:42:59 INFO - Running post-action listener: _package_coverage_data 16:42:59 INFO - Running post-action listener: _resource_record_post_action 16:42:59 INFO - [mozharness: 2017-09-05 23:42:59.763359Z] Finished run-tests step (success) 16:42:59 INFO - Running post-run listener: _resource_record_post_run 16:42:59 INFO - Total resource usage - Wall time: 1184s; CPU: 13.0%; Read bytes: 8192; Write bytes: 376360960; Read time: 152; Write time: 216072 16:42:59 INFO - TinderboxPrint: CPU usage
13.1% 16:42:59 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 152 16:42:59 INFO - TinderboxPrint: I/O write bytes / time
376,360,960 / 216,072 16:42:59 INFO - TinderboxPrint: CPU idle
8,206.4 (86.9%) 16:42:59 INFO - TinderboxPrint: CPU user
1,185.6 (12.6%) 16:42:59 INFO - TinderboxPrint: Swap in / out
0 / 0 16:42:59 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 100073472; Read time: 64; Write time: 63244 16:42:59 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 16:42:59 INFO - run-tests - Wall time: 1168s; CPU: 13.0%; Read bytes: 4096; Write bytes: 276287488; Read time: 88; Write time: 152828 16:43:00 INFO - Running post-run listener: _upload_blobber_files 16:43:00 INFO - Blob upload gear active. 16:43:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:43:00 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:43:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:43:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:43:00 INFO - (blobuploader) - INFO - Open directory for files ... 16:43:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:43:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:43:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:43:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:43:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:43:07 INFO - (blobuploader) - INFO - Done attempting. 16:43:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:43:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:43:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:43:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:43:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:43:08 INFO - (blobuploader) - INFO - Done attempting. 16:43:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:43:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:43:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:43:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:43:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:43:09 INFO - (blobuploader) - INFO - Done attempting. 16:43:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:43:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:43:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:43:10 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:43:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:43:10 INFO - (blobuploader) - INFO - Done attempting. 16:43:10 INFO - (blobuploader) - INFO - Iteration through files over. 16:43:10 INFO - Return code: 0 16:43:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:43:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:43:10 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c8a27d3ee8171c4cb9b59b9084349fce3d00616b21d40831f99e156cf9e072567a2977f343c47faf83fdf2a5ef91bea8d577de0dc86abed9ae2d3e66650bfe8e", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cf6fcb9b10142aa3fef9e10831246ead4530a043f8f5f249003bfbff23e7568426e6b383d4c15fa24c511ec6c5a8f7ea671c71205c32788a6460e389cff65725", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bea2979dde6380137fa493663787b7b384cf636ccf7c949894f7dec3bad977c164f514a3062ea4f8fa5b23fccaf94a65f7aa736a1589c5e443668232c3ff91a3", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e3ee8f770252a414e864b369ae5b5a0f4d541dc9f49ade77de3e9ab1b6016b54a93757dfb533b86a288f224029ce9a0ecacce1608aaa1eea305de48ba32b44c6"} 16:43:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:43:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:43:10 INFO - Contents: 16:43:10 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c8a27d3ee8171c4cb9b59b9084349fce3d00616b21d40831f99e156cf9e072567a2977f343c47faf83fdf2a5ef91bea8d577de0dc86abed9ae2d3e66650bfe8e", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cf6fcb9b10142aa3fef9e10831246ead4530a043f8f5f249003bfbff23e7568426e6b383d4c15fa24c511ec6c5a8f7ea671c71205c32788a6460e389cff65725", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bea2979dde6380137fa493663787b7b384cf636ccf7c949894f7dec3bad977c164f514a3062ea4f8fa5b23fccaf94a65f7aa736a1589c5e443668232c3ff91a3", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e3ee8f770252a414e864b369ae5b5a0f4d541dc9f49ade77de3e9ab1b6016b54a93757dfb533b86a288f224029ce9a0ecacce1608aaa1eea305de48ba32b44c6"} 16:43:10 INFO - Running post-run listener: copy_logs_to_upload_dir 16:43:10 INFO - Copying logs to upload dir... 16:43:10 INFO - mkdir: /builds/slave/test/build/upload/logs 16:43:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.343852 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2017-09-05 16:43:10.281976) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-05 16:43:10.285764) ========= 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=03627c79f6bb3d1578c4a402000001ba-1504653743.516103-1680718200 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c8a27d3ee8171c4cb9b59b9084349fce3d00616b21d40831f99e156cf9e072567a2977f343c47faf83fdf2a5ef91bea8d577de0dc86abed9ae2d3e66650bfe8e", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cf6fcb9b10142aa3fef9e10831246ead4530a043f8f5f249003bfbff23e7568426e6b383d4c15fa24c511ec6c5a8f7ea671c71205c32788a6460e389cff65725", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bea2979dde6380137fa493663787b7b384cf636ccf7c949894f7dec3bad977c164f514a3062ea4f8fa5b23fccaf94a65f7aa736a1589c5e443668232c3ff91a3", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e3ee8f770252a414e864b369ae5b5a0f4d541dc9f49ade77de3e9ab1b6016b54a93757dfb533b86a288f224029ce9a0ecacce1608aaa1eea305de48ba32b44c6"} build_url:https://queue.taskcluster.net/v1/task/dnzV977BRkOJkNzKYtz86g/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011261 build_url: 'https://queue.taskcluster.net/v1/task/dnzV977BRkOJkNzKYtz86g/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c8a27d3ee8171c4cb9b59b9084349fce3d00616b21d40831f99e156cf9e072567a2977f343c47faf83fdf2a5ef91bea8d577de0dc86abed9ae2d3e66650bfe8e", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cf6fcb9b10142aa3fef9e10831246ead4530a043f8f5f249003bfbff23e7568426e6b383d4c15fa24c511ec6c5a8f7ea671c71205c32788a6460e389cff65725", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bea2979dde6380137fa493663787b7b384cf636ccf7c949894f7dec3bad977c164f514a3062ea4f8fa5b23fccaf94a65f7aa736a1589c5e443668232c3ff91a3", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e3ee8f770252a414e864b369ae5b5a0f4d541dc9f49ade77de3e9ab1b6016b54a93757dfb533b86a288f224029ce9a0ecacce1608aaa1eea305de48ba32b44c6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-05 16:43:10.313749) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-05 16:43:10.314068) ========= 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=03627c79f6bb3d1578c4a402000001ba-1504653743.516103-1680718200 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004505 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-05 16:43:10.396433) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-05 16:43:10.396785) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-05 16:43:10.397119) ========= ========= Total master_lag: 0.22 =========