builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s slave: talos-linux64-ix-066 starttime: 1506010769.74 results: success (0) revision: b14c75b83d0226333b1240466ea9f07cfb206ff3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-21 09:19:29.744765) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-21 09:19:29.745218) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-21 09:19:29.745531) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-21 09:19:29.793536) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 09:19:29.793836) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1506010768.330791-388580899 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-21 09:19:29-- 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% 61.0M=0s 2017-09-21 09:19:29 (61.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.194853 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 09:19:30.006148) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 09:19:30.006484) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1506010768.330791-388580899 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.025027 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 09:19:30.056686) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 09:19:30.057021) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b14c75b83d0226333b1240466ea9f07cfb206ff3 --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 b14c75b83d0226333b1240466ea9f07cfb206ff3 --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=82c74bd3bc9a11c5833d2010000001e6-1506010768.330791-388580899 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-21 09:19:30,106 truncating revision to first 12 chars 2017-09-21 09:19:30,106 Setting DEBUG logging. 2017-09-21 09:19:30,106 attempt 1/10 2017-09-21 09:19:30,106 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b14c75b83d02?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-21 09:19:30,431 unpacking tar archive at: mozilla-central-b14c75b83d02/testing/mozharness/ program finished with exit code 0 elapsedTime=0.638690 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 09:19:30.711486) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-21 09:19:30.711808) ========= script_repo_revision: b14c75b83d0226333b1240466ea9f07cfb206ff3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-21 09:19:30.712191) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-21 09:19:30.712469) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-21 09:19:30.724906) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2017-09-21 09:19:30.725263) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-stylo-disabled-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=82c74bd3bc9a11c5833d2010000001e6-1506010768.330791-388580899 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:19:31 INFO - MultiFileLogger online at 20170921 09:19:31 in /builds/slave/test 09:19:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 09:19:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:19:31 INFO - {'append_to_log': False, 09:19:31 INFO - 'base_work_dir': '/builds/slave/test', 09:19:31 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 09:19:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:19:31 INFO - 'branch': 'Firefox-Non-PGO', 09:19:31 INFO - 'buildbot_json_path': 'buildprops.json', 09:19:31 INFO - 'code_coverage': False, 09:19:31 INFO - 'config_files': ('talos/linux_config.py',), 09:19:31 INFO - 'default_actions': ('clobber', 09:19:31 INFO - 'read-buildbot-config', 09:19:31 INFO - 'download-and-extract', 09:19:31 INFO - 'populate-webroot', 09:19:31 INFO - 'create-virtualenv', 09:19:31 INFO - 'install', 09:19:31 INFO - 'setup-mitmproxy', 09:19:31 INFO - 'run-tests'), 09:19:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:19:31 INFO - 'disable_ccov_upload': False, 09:19:31 INFO - 'disable_stylo': False, 09:19:31 INFO - 'download_minidump_stackwalk': True, 09:19:31 INFO - 'download_symbols': 'ondemand', 09:19:31 INFO - 'enable_stylo': False, 09:19:31 INFO - 'enable_webrender': False, 09:19:31 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 09:19:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:19:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:19:31 INFO - 'gecko_profile': False, 09:19:31 INFO - 'gecko_profile_interval': 0, 09:19:31 INFO - 'installer_path': 'installer.exe', 09:19:31 INFO - 'log_level': 'info', 09:19:31 INFO - 'log_name': 'talos', 09:19:31 INFO - 'log_to_console': True, 09:19:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:19:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:19:31 INFO - 'opt_config_files': (), 09:19:31 INFO - 'pip_index': False, 09:19:31 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 09:19:31 INFO - 'system_bits': '32', 09:19:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:19:31 INFO - 'title': 'talos-linux64-ix-066', 09:19:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:19:31 INFO - 'use_talos_json': True, 09:19:31 INFO - 'verify': 'False', 09:19:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:19:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:19:31 INFO - 'work_dir': 'build'} 09:19:31 INFO - [mozharness: 2017-09-21 16:19:31.041270Z] Running clobber step. 09:19:31 INFO - Running pre-action listener: _resource_record_pre_action 09:19:31 INFO - Running main action method: clobber 09:19:31 INFO - rmtree: /builds/slave/test/build 09:19:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:19:35 INFO - Running post-action listener: _resource_record_post_action 09:19:35 INFO - [mozharness: 2017-09-21 16:19:35.079208Z] Finished clobber step (success) 09:19:35 INFO - [mozharness: 2017-09-21 16:19:35.079304Z] Running read-buildbot-config step. 09:19:35 INFO - Running pre-action listener: _resource_record_pre_action 09:19:35 INFO - Running main action method: read_buildbot_config 09:19:35 INFO - Using buildbot properties: 09:19:35 INFO - { 09:19:35 INFO - "project": "", 09:19:35 INFO - "product": "firefox", 09:19:35 INFO - "who": "archaeopteryx@coole-files.de", 09:19:35 INFO - "installer_path": "public/build/target.tar.bz2", 09:19:35 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 09:19:35 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 09:19:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-stylo-disabled-e10s", 09:19:35 INFO - "stage_platform": "linux64", 09:19:35 INFO - "basedir": "/builds/slave/test", 09:19:35 INFO - "buildnumber": 33, 09:19:35 INFO - "platform": "ubuntu64_hw", 09:19:35 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:19:35 INFO - "slavebuilddir": "test", 09:19:35 INFO - "taskId": "T1aIzV4FQGWZX9AwOweN9g", 09:19:35 INFO - "branch": "mozilla-central", 09:19:35 INFO - "script_repo_revision": "production", 09:19:35 INFO - "revision": "b14c75b83d0226333b1240466ea9f07cfb206ff3", 09:19:35 INFO - "slavename": "talos-linux64-ix-066", 09:19:35 INFO - "repo_path": "mozilla-central" 09:19:35 INFO - } 09:19:35 INFO - Finding installer, test and symbols from parent task. 09:19:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/T1aIzV4FQGWZX9AwOweN9g'}, attempt #1 09:19:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/T1aIzV4FQGWZX9AwOweN9g'}, attempt #1 09:19:36 INFO - Task dependencies: HBJ4E0WUSRGZbfHgz26VAA 09:19:36 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HBJ4E0WUSRGZbfHgz26VAA'}, attempt #1 09:19:36 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/HBJ4E0WUSRGZbfHgz26VAA/artifacts/public/build/target.tar.bz2 09:19:36 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/HBJ4E0WUSRGZbfHgz26VAA/artifacts/public/build/target.test_packages.json 09:19:36 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/HBJ4E0WUSRGZbfHgz26VAA/artifacts/public/build/target.crashreporter-symbols.zip 09:19:36 INFO - Running post-action listener: _resource_record_post_action 09:19:36 INFO - [mozharness: 2017-09-21 16:19:36.473462Z] Finished read-buildbot-config step (success) 09:19:36 INFO - [mozharness: 2017-09-21 16:19:36.473683Z] Running download-and-extract step. 09:19:36 INFO - Running pre-action listener: _resource_record_pre_action 09:19:36 INFO - Running main action method: download_and_extract 09:19:36 INFO - mkdir: /builds/slave/test/build/tests 09:19:36 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')]} 09:19:36 INFO - trying https://queue.taskcluster.net/v1/task/HBJ4E0WUSRGZbfHgz26VAA/artifacts/public/build/target.test_packages.json 09:19:36 INFO - Downloading https://queue.taskcluster.net/v1/task/HBJ4E0WUSRGZbfHgz26VAA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 09:19:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HBJ4E0WUSRGZbfHgz26VAA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 09:19:37 INFO - Downloaded 989 bytes. 09:19:37 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 09:19:37 INFO - Using the following test package requirements: 09:19:37 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 09:19:37 INFO - u'common': [u'target.common.tests.zip'], 09:19:37 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 09:19:37 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 09:19:37 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 09:19:37 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 09:19:37 INFO - u'mozbase': [u'target.common.tests.zip'], 09:19:37 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 09:19:37 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 09:19:37 INFO - u'web-platform': [u'target.common.tests.zip', 09:19:37 INFO - u'target.web-platform.tests.tar.gz'], 09:19:37 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 09:19:37 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 09:19:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HBJ4E0WUSRGZbfHgz26VAA/artifacts/public/build/target.common.tests.zip 09:19:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HBJ4E0WUSRGZbfHgz26VAA/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:19:37 INFO - Fetch https://queue.taskcluster.net/v1/task/HBJ4E0WUSRGZbfHgz26VAA/artifacts/public/build/target.common.tests.zip into memory 09:19:38 INFO - Content-Length response header: 54741041 09:19:38 INFO - Bytes received: 54741041 09:19:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HBJ4E0WUSRGZbfHgz26VAA/artifacts/public/build/target.talos.tests.zip 09:19:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HBJ4E0WUSRGZbfHgz26VAA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 09:19:48 INFO - Fetch https://queue.taskcluster.net/v1/task/HBJ4E0WUSRGZbfHgz26VAA/artifacts/public/build/target.talos.tests.zip into memory 09:19:49 INFO - Content-Length response header: 14509184 09:19:49 INFO - Bytes received: 14509184 09:19:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:49 INFO - trying https://queue.taskcluster.net/v1/task/HBJ4E0WUSRGZbfHgz26VAA/artifacts/public/build/target.tar.bz2 09:19:49 INFO - Downloading https://queue.taskcluster.net/v1/task/HBJ4E0WUSRGZbfHgz26VAA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 09:19:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HBJ4E0WUSRGZbfHgz26VAA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 09:19:50 INFO - Downloaded 61526732 bytes. 09:19:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HBJ4E0WUSRGZbfHgz26VAA/artifacts/public/build/target.tar.bz2 09:19:50 INFO - mkdir: /builds/slave/test/properties 09:19:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:19:50 INFO - Writing to file /builds/slave/test/properties/build_url 09:19:50 INFO - Contents: 09:19:50 INFO - build_url:https://queue.taskcluster.net/v1/task/HBJ4E0WUSRGZbfHgz26VAA/artifacts/public/build/target.tar.bz2 09:19:50 INFO - Running post-action listener: _resource_record_post_action 09:19:50 INFO - Running post-action listener: find_tests_for_verification 09:19:50 INFO - Running post-action listener: set_extra_try_arguments 09:19:50 INFO - [mozharness: 2017-09-21 16:19:50.869483Z] Finished download-and-extract step (success) 09:19:50 INFO - [mozharness: 2017-09-21 16:19:50.869578Z] Running populate-webroot step. 09:19:50 INFO - Running pre-action listener: _resource_record_pre_action 09:19:50 INFO - Running main action method: populate_webroot 09:19:50 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:19:50 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:19:50 INFO - 'tests': ['tresize', 09:19:50 INFO - 'tcanvasmark']}, 09:19:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:19:50 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:19:50 INFO - 'tests': ['dromaeo_css', 09:19:50 INFO - 'kraken']}, 09:19:50 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:19:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:19:50 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 09:19:50 INFO - 'talos_options': ['--disable-stylo'], 09:19:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:19:50 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:19:50 INFO - 'tests': ['damp', 'tps']}, 09:19:50 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 09:19:50 INFO - 'talos_options': ['--disable-stylo'], 09:19:50 INFO - 'tests': ['damp', 'tps']}, 09:19:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:19:50 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:19:50 INFO - 'tests': ['dromaeo_dom']}, 09:19:50 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 09:19:50 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:19:50 INFO - 'tests': ['basic_compositor_video', 09:19:50 INFO - 'glvideo']}, 09:19:50 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 09:19:50 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 09:19:50 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 09:19:50 INFO - 'talos_options': ['--disable-stylo'], 09:19:50 INFO - 'tests': ['ts_paint_webext', 09:19:50 INFO - 'tp5o_webext']}, 09:19:50 INFO - 'other-e10s': {'tests': ['a11yr', 09:19:50 INFO - 'ts_paint', 09:19:50 INFO - 'tpaint', 09:19:50 INFO - 'sessionrestore', 09:19:50 INFO - 'sessionrestore_many_windows', 09:19:50 INFO - 'sessionrestore_no_auto_restore', 09:19:50 INFO - 'tabpaint']}, 09:19:50 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:19:50 INFO - 'tests': ['a11yr', 09:19:50 INFO - 'ts_paint', 09:19:50 INFO - 'tpaint', 09:19:50 INFO - 'sessionrestore', 09:19:50 INFO - 'sessionrestore_many_windows', 09:19:50 INFO - 'sessionrestore_no_auto_restore', 09:19:50 INFO - 'tabpaint']}, 09:19:50 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 09:19:50 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 09:19:50 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:19:50 INFO - 'tests': ['perf_reftest_singletons']}, 09:19:50 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:19:50 INFO - 'tests': ['bloom_basic']}, 09:19:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:19:50 INFO - 'tsvgr_opacity', 09:19:50 INFO - 'tart', 09:19:50 INFO - 'tscrollx', 09:19:50 INFO - 'tsvg_static']}, 09:19:50 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:19:50 INFO - 'tests': ['tsvgx', 09:19:50 INFO - 'tsvgr_opacity', 09:19:50 INFO - 'tart', 09:19:50 INFO - 'tscrollx', 09:19:50 INFO - 'tsvg_static']}, 09:19:50 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:19:50 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 09:19:50 INFO - 'talos_options': ['--disable-stylo'], 09:19:50 INFO - 'tests': ['tp5o']}, 09:19:50 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 09:19:50 INFO - 'talos_options': ['--mitmproxy', 09:19:50 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 09:19:50 INFO - '--firstNonBlankPaint'], 09:19:50 INFO - 'tests': ['tp6_google', 09:19:50 INFO - 'tp6_youtube', 09:19:50 INFO - 'tp6_amazon', 09:19:50 INFO - 'tp6_facebook']}, 09:19:50 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 09:19:50 INFO - 'talos_options': ['--disable-stylo', 09:19:50 INFO - '--mitmproxy', 09:19:50 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 09:19:50 INFO - '--firstNonBlankPaint'], 09:19:50 INFO - 'tests': ['tp6_google', 09:19:50 INFO - 'tp6_youtube', 09:19:50 INFO - 'tp6_amazon', 09:19:50 INFO - 'tp6_facebook']}, 09:19:50 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 09:19:50 INFO - 'talos_options': ['--stylo-threads=1', 09:19:50 INFO - '--mitmproxy', 09:19:50 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 09:19:50 INFO - '--firstNonBlankPaint'], 09:19:50 INFO - 'tests': ['tp6_google', 09:19:50 INFO - 'tp6_youtube', 09:19:50 INFO - 'tp6_amazon', 09:19:50 INFO - 'tp6_facebook']}, 09:19:50 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:19:50 INFO - 'talos_options': ['--xperf_path', 09:19:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:19:50 INFO - 'tests': ['tp5n']}, 09:19:50 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 09:19:50 INFO - 'talos_options': ['--disable-stylo', 09:19:50 INFO - '--xperf_path', 09:19:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:19:50 INFO - 'tests': ['tp5n']}}} 09:19:50 INFO - Running post-action listener: _resource_record_post_action 09:19:50 INFO - [mozharness: 2017-09-21 16:19:50.884559Z] Finished populate-webroot step (success) 09:19:50 INFO - [mozharness: 2017-09-21 16:19:50.884648Z] Running create-virtualenv step. 09:19:50 INFO - Running pre-action listener: _resource_record_pre_action 09:19:50 INFO - Running main action method: create_virtualenv 09:19:50 INFO - Creating virtualenv /builds/slave/test/build/venv 09:19:50 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:19:50 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 09:19:50 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 09:19:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:19:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:19:53 INFO - Installing distribute.............................................................................................................................................................................................done. 09:19:53 INFO - Installing pip...............done. 09:19:53 INFO - Return code: 0 09:19:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:19:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:19:53 INFO - Reading from file tmpfile_stdout 09:19:53 INFO - Output received: 09:19:53 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 09:19:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:19:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:53 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 0x21ec1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2558a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255c090>, '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 0x255cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2556f90>, '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': '82c74bd3bc9a11c5833d2010000001e6-1506010768.330791-388580899', '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 09:19:53 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 09:19:53 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 09:19:53 INFO - Using env: {'DISPLAY': ':0', 09:19:53 INFO - 'HOME': '/home/cltbld', 09:19:53 INFO - 'LANG': 'en_US.UTF-8', 09:19:53 INFO - 'LANGUAGE': 'en_US:en', 09:19:53 INFO - 'LOGNAME': 'cltbld', 09:19:53 INFO - 'MAIL': '/var/mail/cltbld', 09:19:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:53 INFO - 'MOZ_NO_REMOTE': '1', 09:19:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:53 INFO - 'NO_EM_RESTART': '1', 09:19:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:53 INFO - 'PWD': '/builds/slave/test', 09:19:53 INFO - 'SHELL': '/bin/bash', 09:19:53 INFO - 'SHLVL': '1', 09:19:53 INFO - 'TERM': 'linux', 09:19:53 INFO - 'TMOUT': '86400', 09:19:53 INFO - 'USER': 'cltbld', 09:19:53 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1506010768.330791-388580899', 09:19:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:53 INFO - '_': '/tools/buildbot/bin/python'} 09:19:54 INFO - Ignoring indexes: http://pypi.python.org/simple/ 09:19:54 INFO - Downloading/unpacking pip>=1.5 09:19:54 INFO - Running setup.py egg_info for package pip 09:19:54 INFO - warning: no files found matching 'pip/cacert.pem' 09:19:54 INFO - warning: no files found matching '*.html' under directory 'docs' 09:19:54 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 09:19:54 INFO - no previously-included directories found matching 'docs/_build/_sources' 09:19:54 INFO - Installing collected packages: pip 09:19:54 INFO - Found existing installation: pip 1.1 09:19:54 INFO - Uninstalling pip: 09:19:54 INFO - Successfully uninstalled pip 09:19:54 INFO - Running setup.py install for pip 09:19:54 INFO - warning: no files found matching 'pip/cacert.pem' 09:19:54 INFO - warning: no files found matching '*.html' under directory 'docs' 09:19:54 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 09:19:54 INFO - no previously-included directories found matching 'docs/_build/_sources' 09:19:54 INFO - Installing pip script to /builds/slave/test/build/venv/bin 09:19:54 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 09:19:54 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 09:19:54 INFO - Successfully installed pip 09:19:54 INFO - Cleaning up... 09:19:54 INFO - Return code: 0 09:19:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:19:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ec1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2558a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255c090>, '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 0x255cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2556f90>, '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': '82c74bd3bc9a11c5833d2010000001e6-1506010768.330791-388580899', '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 09:19:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:19:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:19:54 INFO - Using env: {'DISPLAY': ':0', 09:19:54 INFO - 'HOME': '/home/cltbld', 09:19:54 INFO - 'LANG': 'en_US.UTF-8', 09:19:54 INFO - 'LANGUAGE': 'en_US:en', 09:19:54 INFO - 'LOGNAME': 'cltbld', 09:19:54 INFO - 'MAIL': '/var/mail/cltbld', 09:19:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:54 INFO - 'MOZ_NO_REMOTE': '1', 09:19:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:54 INFO - 'NO_EM_RESTART': '1', 09:19:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:54 INFO - 'PWD': '/builds/slave/test', 09:19:54 INFO - 'SHELL': '/bin/bash', 09:19:54 INFO - 'SHLVL': '1', 09:19:54 INFO - 'TERM': 'linux', 09:19:54 INFO - 'TMOUT': '86400', 09:19:54 INFO - 'USER': 'cltbld', 09:19:54 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1506010768.330791-388580899', 09:19:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:54 INFO - '_': '/tools/buildbot/bin/python'} 09:19:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:55 INFO - Downloading/unpacking psutil>=3.1.1 09:19:55 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 09:19:55 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 09:19:55 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 09:19:55 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 09:19:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:19:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:19:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:19:56 INFO - Installing collected packages: psutil 09:19:56 INFO - Running setup.py install for psutil 09:19:56 INFO - building 'psutil._psutil_linux' extension 09:19:56 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 09:19:58 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:19:58 INFO - building 'psutil._psutil_posix' extension 09:19:58 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 09:19:58 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:19:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:19:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:19:58 INFO - Successfully installed psutil 09:19:58 INFO - Cleaning up... 09:19:58 INFO - Return code: 0 09:19:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:19: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')]} 09:19:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19: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')]} 09:19:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ec1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2558a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255c090>, '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 0x255cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2556f90>, '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': '82c74bd3bc9a11c5833d2010000001e6-1506010768.330791-388580899', '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 09:19:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:19:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:19:58 INFO - Using env: {'DISPLAY': ':0', 09:19:58 INFO - 'HOME': '/home/cltbld', 09:19:58 INFO - 'LANG': 'en_US.UTF-8', 09:19:58 INFO - 'LANGUAGE': 'en_US:en', 09:19:58 INFO - 'LOGNAME': 'cltbld', 09:19:58 INFO - 'MAIL': '/var/mail/cltbld', 09:19:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:58 INFO - 'MOZ_NO_REMOTE': '1', 09:19:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:58 INFO - 'NO_EM_RESTART': '1', 09:19:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:58 INFO - 'PWD': '/builds/slave/test', 09:19:58 INFO - 'SHELL': '/bin/bash', 09:19:58 INFO - 'SHLVL': '1', 09:19:58 INFO - 'TERM': 'linux', 09:19:58 INFO - 'TMOUT': '86400', 09:19:58 INFO - 'USER': 'cltbld', 09:19:58 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1506010768.330791-388580899', 09:19:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:58 INFO - '_': '/tools/buildbot/bin/python'} 09:19:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:19: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 09:19: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 09:19: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 09:19: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 09:19:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:19:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:19:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:19:59 INFO - Installing collected packages: mozsystemmonitor 09:19:59 INFO - Running setup.py install for mozsystemmonitor 09:19:59 INFO - Successfully installed mozsystemmonitor 09:19:59 INFO - Cleaning up... 09:20:00 INFO - Return code: 0 09:20:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:20: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')]} 09:20:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:20: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')]} 09:20:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:20:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ec1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2558a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255c090>, '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 0x255cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2556f90>, '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': '82c74bd3bc9a11c5833d2010000001e6-1506010768.330791-388580899', '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 09:20:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:20:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:20:00 INFO - Using env: {'DISPLAY': ':0', 09:20:00 INFO - 'HOME': '/home/cltbld', 09:20:00 INFO - 'LANG': 'en_US.UTF-8', 09:20:00 INFO - 'LANGUAGE': 'en_US:en', 09:20:00 INFO - 'LOGNAME': 'cltbld', 09:20:00 INFO - 'MAIL': '/var/mail/cltbld', 09:20:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:00 INFO - 'MOZ_NO_REMOTE': '1', 09:20:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:20:00 INFO - 'NO_EM_RESTART': '1', 09:20:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:20:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:00 INFO - 'PWD': '/builds/slave/test', 09:20:00 INFO - 'SHELL': '/bin/bash', 09:20:00 INFO - 'SHLVL': '1', 09:20:00 INFO - 'TERM': 'linux', 09:20:00 INFO - 'TMOUT': '86400', 09:20:00 INFO - 'USER': 'cltbld', 09:20:00 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1506010768.330791-388580899', 09:20:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:00 INFO - '_': '/tools/buildbot/bin/python'} 09:20:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:20:00 INFO - Downloading/unpacking jsonschema==2.5.1 09:20: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 09:20: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 09:20: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 09:20: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 09:20:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:20:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:20:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:20:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:20:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:20:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:20:01 INFO - Downloading functools32-3.2.3-2.tar.gz 09:20:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:20:01 INFO - warning: no files found matching '*.txt' 09:20:01 INFO - no previously-included directories found matching 'build' 09:20:01 INFO - no previously-included directories found matching 'dist' 09:20:01 INFO - no previously-included directories found matching '.git*' 09:20:01 INFO - Installing collected packages: jsonschema, functools32 09:20:01 INFO - Running setup.py install for functools32 09:20:01 INFO - warning: no files found matching '*.txt' 09:20:01 INFO - no previously-included directories found matching 'build' 09:20:01 INFO - no previously-included directories found matching 'dist' 09:20:01 INFO - no previously-included directories found matching '.git*' 09:20:01 INFO - Successfully installed jsonschema functools32 09:20:01 INFO - Cleaning up... 09:20:01 INFO - Return code: 0 09:20:01 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:20: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')]} 09:20:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:20: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')]} 09:20:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:20:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ec1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2558a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255c090>, '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 0x255cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2556f90>, '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': '82c74bd3bc9a11c5833d2010000001e6-1506010768.330791-388580899', '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 09:20:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:20:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:20:01 INFO - Using env: {'DISPLAY': ':0', 09:20:01 INFO - 'HOME': '/home/cltbld', 09:20:01 INFO - 'LANG': 'en_US.UTF-8', 09:20:01 INFO - 'LANGUAGE': 'en_US:en', 09:20:01 INFO - 'LOGNAME': 'cltbld', 09:20:01 INFO - 'MAIL': '/var/mail/cltbld', 09:20:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:01 INFO - 'MOZ_NO_REMOTE': '1', 09:20:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:20:01 INFO - 'NO_EM_RESTART': '1', 09:20:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:20:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:01 INFO - 'PWD': '/builds/slave/test', 09:20:01 INFO - 'SHELL': '/bin/bash', 09:20:01 INFO - 'SHLVL': '1', 09:20:01 INFO - 'TERM': 'linux', 09:20:01 INFO - 'TMOUT': '86400', 09:20:01 INFO - 'USER': 'cltbld', 09:20:01 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1506010768.330791-388580899', 09:20:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:01 INFO - '_': '/tools/buildbot/bin/python'} 09:20:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:20:01 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:20:01 INFO - Cleaning up... 09:20:01 INFO - Return code: 0 09:20:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:20: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')]} 09:20:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:20: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')]} 09:20:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:20: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', '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 0x21ec1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2558a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255c090>, '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 0x255cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2556f90>, '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': '82c74bd3bc9a11c5833d2010000001e6-1506010768.330791-388580899', '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 09:20: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:20: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 blobuploader==1.2.4 09:20:01 INFO - Using env: {'DISPLAY': ':0', 09:20:01 INFO - 'HOME': '/home/cltbld', 09:20:01 INFO - 'LANG': 'en_US.UTF-8', 09:20:01 INFO - 'LANGUAGE': 'en_US:en', 09:20:01 INFO - 'LOGNAME': 'cltbld', 09:20:01 INFO - 'MAIL': '/var/mail/cltbld', 09:20:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:01 INFO - 'MOZ_NO_REMOTE': '1', 09:20:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:20:01 INFO - 'NO_EM_RESTART': '1', 09:20:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:20:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:01 INFO - 'PWD': '/builds/slave/test', 09:20:01 INFO - 'SHELL': '/bin/bash', 09:20:01 INFO - 'SHLVL': '1', 09:20:01 INFO - 'TERM': 'linux', 09:20:01 INFO - 'TMOUT': '86400', 09:20:01 INFO - 'USER': 'cltbld', 09:20:01 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1506010768.330791-388580899', 09:20:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:01 INFO - '_': '/tools/buildbot/bin/python'} 09:20:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:20:02 INFO - Downloading/unpacking blobuploader==1.2.4 09:20: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 09:20: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 09:20: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 09:20: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 09:20:03 INFO - Downloading blobuploader-1.2.4.tar.gz 09:20:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:20:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:20: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 09:20: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 09:20: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 09:20: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 09:20:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:20:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:20: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 09:20: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 09:20: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 09:20: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 09:20:03 INFO - Downloading docopt-0.6.1.tar.gz 09:20:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:20:03 INFO - Installing collected packages: blobuploader, requests, docopt 09:20:03 INFO - Running setup.py install for blobuploader 09:20:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:20:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:20:04 INFO - Running setup.py install for requests 09:20:04 INFO - Running setup.py install for docopt 09:20:04 INFO - Successfully installed blobuploader requests docopt 09:20:04 INFO - Cleaning up... 09:20:05 INFO - Return code: 0 09:20:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:20:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:20:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:20:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:20:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:20:05 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 0x21ec1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2558a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255c090>, '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 0x255cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2556f90>, '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': '82c74bd3bc9a11c5833d2010000001e6-1506010768.330791-388580899', '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 09:20:05 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 09:20:05 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 09:20:05 INFO - Using env: {'DISPLAY': ':0', 09:20:05 INFO - 'HOME': '/home/cltbld', 09:20:05 INFO - 'LANG': 'en_US.UTF-8', 09:20:05 INFO - 'LANGUAGE': 'en_US:en', 09:20:05 INFO - 'LOGNAME': 'cltbld', 09:20:05 INFO - 'MAIL': '/var/mail/cltbld', 09:20:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:05 INFO - 'MOZ_NO_REMOTE': '1', 09:20:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:20:05 INFO - 'NO_EM_RESTART': '1', 09:20:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:20:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:05 INFO - 'PWD': '/builds/slave/test', 09:20:05 INFO - 'SHELL': '/bin/bash', 09:20:05 INFO - 'SHLVL': '1', 09:20:05 INFO - 'TERM': 'linux', 09:20:05 INFO - 'TMOUT': '86400', 09:20:05 INFO - 'USER': 'cltbld', 09:20:05 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1506010768.330791-388580899', 09:20:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:05 INFO - '_': '/tools/buildbot/bin/python'} 09:20:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:20:05 INFO - Running setup.py (path:/tmp/pip-hPsb6J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:20:05 INFO - Running setup.py (path:/tmp/pip-w0HEAg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:20:05 INFO - Running setup.py (path:/tmp/pip-crDW0t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:20:05 INFO - Running setup.py (path:/tmp/pip-PIgEoi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:20:05 INFO - Running setup.py (path:/tmp/pip-kqHNBH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:20:05 INFO - Running setup.py (path:/tmp/pip-6NYuCk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:20:05 INFO - Running setup.py (path:/tmp/pip-2EBKAq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:20:05 INFO - Running setup.py (path:/tmp/pip-cCDSuU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:20:05 INFO - Running setup.py (path:/tmp/pip-L7MrWp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:20:06 INFO - Running setup.py (path:/tmp/pip-PVLNRt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:20:06 INFO - Running setup.py (path:/tmp/pip-7MJchQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:20:06 INFO - Running setup.py (path:/tmp/pip-qR5aAd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:20:06 INFO - Running setup.py (path:/tmp/pip-uwrXfH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:20:06 INFO - Running setup.py (path:/tmp/pip-f18w8K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:20:06 INFO - Running setup.py (path:/tmp/pip-9_BkE2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:20:06 INFO - Running setup.py (path:/tmp/pip-F9aqNp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:20:06 INFO - Running setup.py (path:/tmp/pip-itGmY6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:20:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:20:06 INFO - Running setup.py install for manifestparser 09:20:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:20:06 INFO - Running setup.py install for mozcrash 09:20:06 INFO - Running setup.py install for mozdebug 09:20:06 INFO - Running setup.py install for mozdevice 09:20:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:20:06 INFO - Running setup.py install for mozfile 09:20:07 INFO - Running setup.py install for mozhttpd 09:20:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:20:07 INFO - Running setup.py install for mozinfo 09:20:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:20:07 INFO - Running setup.py install for mozInstall 09:20:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:20:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:20:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:20:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:20:07 INFO - Running setup.py install for mozleak 09:20:07 INFO - Running setup.py install for mozlog 09:20:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:20:07 INFO - Running setup.py install for moznetwork 09:20:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:20:07 INFO - Running setup.py install for mozprocess 09:20:07 INFO - Running setup.py install for mozprofile 09:20:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:20:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:20:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:20:07 INFO - Running setup.py install for mozrunner 09:20:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:20:07 INFO - Running setup.py install for mozscreenshot 09:20:08 INFO - Running setup.py install for moztest 09:20:08 INFO - Running setup.py install for mozversion 09:20:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:20:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:20:08 INFO - Cleaning up... 09:20:08 INFO - Return code: 0 09:20:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:20:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:20:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:20:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:20:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:20:08 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 0x21ec1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2558a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255c090>, '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 0x255cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2556f90>, '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': '82c74bd3bc9a11c5833d2010000001e6-1506010768.330791-388580899', '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 09:20:08 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 09:20:08 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 09:20:08 INFO - Using env: {'DISPLAY': ':0', 09:20:08 INFO - 'HOME': '/home/cltbld', 09:20:08 INFO - 'LANG': 'en_US.UTF-8', 09:20:08 INFO - 'LANGUAGE': 'en_US:en', 09:20:08 INFO - 'LOGNAME': 'cltbld', 09:20:08 INFO - 'MAIL': '/var/mail/cltbld', 09:20:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:08 INFO - 'MOZ_NO_REMOTE': '1', 09:20:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:20:08 INFO - 'NO_EM_RESTART': '1', 09:20:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:20:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:08 INFO - 'PWD': '/builds/slave/test', 09:20:08 INFO - 'SHELL': '/bin/bash', 09:20:08 INFO - 'SHLVL': '1', 09:20:08 INFO - 'TERM': 'linux', 09:20:08 INFO - 'TMOUT': '86400', 09:20:08 INFO - 'USER': 'cltbld', 09:20:08 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1506010768.330791-388580899', 09:20:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:08 INFO - '_': '/tools/buildbot/bin/python'} 09:20:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:20:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:20:08 INFO - Running setup.py (path:/tmp/pip-R9Itxd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:20:08 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)) 09:20:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:20:08 INFO - Running setup.py (path:/tmp/pip-uGWZPl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:20:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:20:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:20:08 INFO - Running setup.py (path:/tmp/pip-O7ab67-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:20:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:20:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:20:08 INFO - Running setup.py (path:/tmp/pip-xcS5IR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:20:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:20:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:20:08 INFO - Running setup.py (path:/tmp/pip-JpqZEb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:20:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:20:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:20:08 INFO - Running setup.py (path:/tmp/pip-kPH8CX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:20:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:20:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:20:08 INFO - Running setup.py (path:/tmp/pip-V6zNia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:20:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:20:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:20:08 INFO - Running setup.py (path:/tmp/pip-V3ZtvO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:20:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:20:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:20:08 INFO - Running setup.py (path:/tmp/pip-ruqSx6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:20:09 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)) 09:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:20:09 INFO - Running setup.py (path:/tmp/pip-02H4AT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:20:09 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)) 09:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:20:09 INFO - Running setup.py (path:/tmp/pip-FKV9J0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:20:09 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)) 09:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:20:09 INFO - Running setup.py (path:/tmp/pip-vpV2C3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:20:09 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)) 09:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:20:09 INFO - Running setup.py (path:/tmp/pip-7QKyGc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:20:09 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)) 09:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:20:09 INFO - Running setup.py (path:/tmp/pip-GM11Hu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:20:09 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)) 09:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:20:09 INFO - Running setup.py (path:/tmp/pip-Yu10CG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:20:09 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)) 09:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:20:09 INFO - Running setup.py (path:/tmp/pip-aip1nR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:20:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:20:09 INFO - Running setup.py (path:/tmp/pip-sIuvrB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:20:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:20:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:20:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:20:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:20:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:20:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:20:09 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:20:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:20:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:20:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:20:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:20:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:20:10 INFO - Downloading blessings-1.6.tar.gz 09:20:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:20:11 INFO - Installing collected packages: blessings 09:20:11 INFO - Running setup.py install for blessings 09:20:11 INFO - Successfully installed blessings 09:20:11 INFO - Cleaning up... 09:20:11 INFO - Return code: 0 09:20:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:20:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:20:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:20:11 INFO - Reading from file tmpfile_stdout 09:20:11 INFO - Current package versions: 09:20:11 INFO - argparse == 1.2.1 09:20:11 INFO - blessings == 1.6 09:20:11 INFO - blobuploader == 1.2.4 09:20:11 INFO - docopt == 0.6.1 09:20:11 INFO - functools32 == 3.2.3-2 09:20:11 INFO - jsonschema == 2.5.1 09:20:11 INFO - manifestparser == 1.1 09:20:11 INFO - mozInstall == 1.13 09:20:11 INFO - mozcrash == 1.0 09:20:11 INFO - mozdebug == 0.1 09:20:11 INFO - mozdevice == 0.51 09:20:11 INFO - mozfile == 1.2 09:20:11 INFO - mozhttpd == 0.7 09:20:11 INFO - mozinfo == 0.10 09:20:11 INFO - mozleak == 0.1 09:20:11 INFO - mozlog == 3.5 09:20:11 INFO - moznetwork == 0.27 09:20:11 INFO - mozprocess == 0.25 09:20:11 INFO - mozprofile == 0.28 09:20:11 INFO - mozrunner == 6.13 09:20:11 INFO - mozscreenshot == 0.1 09:20:11 INFO - mozsystemmonitor == 0.3 09:20:11 INFO - moztest == 0.8 09:20:11 INFO - mozversion == 1.4 09:20:11 INFO - psutil == 3.1.1 09:20:11 INFO - requests == 1.2.3 09:20:11 INFO - wsgiref == 0.1.2 09:20:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:20:11 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')]} 09:20:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:20:11 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')]} 09:20:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:20:11 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 0x21ec1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2558a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255c090>, '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 0x255cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2556f90>, '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': '82c74bd3bc9a11c5833d2010000001e6-1506010768.330791-388580899', '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 09:20:11 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 09:20:11 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 09:20:11 INFO - Using env: {'DISPLAY': ':0', 09:20:11 INFO - 'HOME': '/home/cltbld', 09:20:11 INFO - 'LANG': 'en_US.UTF-8', 09:20:11 INFO - 'LANGUAGE': 'en_US:en', 09:20:11 INFO - 'LOGNAME': 'cltbld', 09:20:11 INFO - 'MAIL': '/var/mail/cltbld', 09:20:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:11 INFO - 'MOZ_NO_REMOTE': '1', 09:20:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:20:11 INFO - 'NO_EM_RESTART': '1', 09:20:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:20:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:11 INFO - 'PWD': '/builds/slave/test', 09:20:11 INFO - 'SHELL': '/bin/bash', 09:20:11 INFO - 'SHLVL': '1', 09:20:11 INFO - 'TERM': 'linux', 09:20:11 INFO - 'TMOUT': '86400', 09:20:11 INFO - 'USER': 'cltbld', 09:20:11 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1506010768.330791-388580899', 09:20:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:11 INFO - '_': '/tools/buildbot/bin/python'} 09:20:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:20:11 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)) 09:20:11 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)) 09:20:11 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)) 09:20:11 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)) 09:20:11 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)) 09:20:11 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)) 09:20:11 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)) 09:20:11 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)) 09:20:11 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)) 09:20:11 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 09:20:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:20:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:20:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:20:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:20:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 09:20:12 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:20:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:20:12 INFO - Installing collected packages: simplejson 09:20:12 INFO - Running setup.py install for simplejson 09:20:12 INFO - building 'simplejson._speedups' extension 09:20:12 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 09:20:13 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 09:20:13 INFO - Successfully installed simplejson 09:20:13 INFO - Cleaning up... 09:20:13 INFO - Return code: 0 09:20:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:20:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:20:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:20:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:20:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:20:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ec1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2558a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255c090>, '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 0x255cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2556f90>, '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': '82c74bd3bc9a11c5833d2010000001e6-1506010768.330791-388580899', '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 09:20:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:20:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:20:13 INFO - Using env: {'DISPLAY': ':0', 09:20:13 INFO - 'HOME': '/home/cltbld', 09:20:13 INFO - 'LANG': 'en_US.UTF-8', 09:20:13 INFO - 'LANGUAGE': 'en_US:en', 09:20:13 INFO - 'LOGNAME': 'cltbld', 09:20:13 INFO - 'MAIL': '/var/mail/cltbld', 09:20:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:13 INFO - 'MOZ_NO_REMOTE': '1', 09:20:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:20:13 INFO - 'NO_EM_RESTART': '1', 09:20:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:20:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:13 INFO - 'PWD': '/builds/slave/test', 09:20:13 INFO - 'SHELL': '/bin/bash', 09:20:13 INFO - 'SHLVL': '1', 09:20:13 INFO - 'TERM': 'linux', 09:20:13 INFO - 'TMOUT': '86400', 09:20:13 INFO - 'USER': 'cltbld', 09:20:13 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1506010768.330791-388580899', 09:20:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:13 INFO - '_': '/tools/buildbot/bin/python'} 09:20:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:20:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:20:14 INFO - Cleaning up... 09:20:14 INFO - Return code: 0 09:20:14 INFO - Running post-action listener: _resource_record_post_action 09:20:14 INFO - Running post-action listener: _start_resource_monitoring 09:20:14 INFO - Starting resource monitoring. 09:20:14 INFO - [mozharness: 2017-09-21 16:20:14.186536Z] Finished create-virtualenv step (success) 09:20:14 INFO - [mozharness: 2017-09-21 16:20:14.187493Z] Running install step. 09:20:14 INFO - Running pre-action listener: _resource_record_pre_action 09:20:14 INFO - Running main action method: install 09:20:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:20:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:20:14 INFO - Reading from file tmpfile_stdout 09:20:14 INFO - Detecting whether we're running mozinstall >=1.0... 09:20:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:20:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:20:14 INFO - Reading from file tmpfile_stdout 09:20:14 INFO - Output received: 09:20:14 INFO - Usage: mozinstall [options] installer 09:20:14 INFO - Options: 09:20:14 INFO - -h, --help show this help message and exit 09:20:14 INFO - -d DEST, --destination=DEST 09:20:14 INFO - Directory to install application into. [default: 09:20:14 INFO - "/builds/slave/test"] 09:20:14 INFO - --app=APP Application being installed. [default: firefox] 09:20:14 INFO - mkdir: /builds/slave/test/build/application 09:20:14 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'] 09:20:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 09:20:32 INFO - Reading from file tmpfile_stdout 09:20:32 INFO - Output received: 09:20:32 INFO - /builds/slave/test/build/application/firefox/firefox 09:20:32 INFO - Running post-action listener: _resource_record_post_action 09:20:32 INFO - [mozharness: 2017-09-21 16:20:32.286053Z] Finished install step (success) 09:20:32 INFO - [mozharness: 2017-09-21 16:20:32.286308Z] Running setup-mitmproxy step. 09:20:32 INFO - Running pre-action listener: _resource_record_pre_action 09:20:32 INFO - Running main action method: setup_mitmproxy 09:20:32 INFO - Skipping: mitmproxy is not required 09:20:32 INFO - Running post-action listener: _resource_record_post_action 09:20:32 INFO - [mozharness: 2017-09-21 16:20:32.287448Z] Finished setup-mitmproxy step (success) 09:20:32 INFO - [mozharness: 2017-09-21 16:20:32.287668Z] Running run-tests step. 09:20:32 INFO - Running pre-action listener: _resource_record_pre_action 09:20:32 INFO - Running pre-action listener: _set_gcov_prefix 09:20:32 INFO - Running main action method: run_tests 09:20:32 WARNING - Try message not found. 09:20:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:20:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:20:32 INFO - Python 2.7.3 09:20:32 INFO - Return code: 0 09:20:32 INFO - grabbing minidump binary from tooltool 09:20:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:20:32 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255c090>, '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 0x255cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2556f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:20:32 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:20:32 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:20:32 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:20:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:20:32 INFO - Return code: 0 09:20:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:20:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:20:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:20:32 INFO - ENV: RUST_BACKTRACE is now full 09:20:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:20:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:20:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HBJ4E0WUSRGZbfHgz26VAA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] in /builds/slave/test/build 09:20:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HBJ4E0WUSRGZbfHgz26VAA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-066 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log 09:20:32 INFO - Using env: {'DISPLAY': ':0', 09:20:32 INFO - 'HOME': '/home/cltbld', 09:20:32 INFO - 'LANG': 'en_US.UTF-8', 09:20:32 INFO - 'LANGUAGE': 'en_US:en', 09:20:32 INFO - 'LOGNAME': 'cltbld', 09:20:32 INFO - 'MAIL': '/var/mail/cltbld', 09:20:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:20:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:20:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:32 INFO - 'MOZ_NO_REMOTE': '1', 09:20:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:20:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:20:32 INFO - 'NO_EM_RESTART': '1', 09:20:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:20:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:32 INFO - 'PWD': '/builds/slave/test', 09:20:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:20:32 INFO - 'RUST_BACKTRACE': 'full', 09:20:32 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 09:20:32 INFO - 'SHELL': '/bin/bash', 09:20:32 INFO - 'SHLVL': '1', 09:20:32 INFO - 'TERM': 'linux', 09:20:32 INFO - 'TMOUT': '86400', 09:20:32 INFO - 'USER': 'cltbld', 09:20:32 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1506010768.330791-388580899', 09:20:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:32 INFO - '_': '/tools/buildbot/bin/python'} 09:20:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HBJ4E0WUSRGZbfHgz26VAA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] with output_timeout 3600 09:20:32 INFO - mozversion application_buildid: 20170921152748 09:20:32 INFO - mozversion application_changeset: b14c75b83d0226333b1240466ea9f07cfb206ff3 09:20:32 INFO - mozversion application_display_name: Nightly 09:20:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:20:32 INFO - mozversion application_name: Firefox 09:20:32 INFO - mozversion application_remotingname: firefox 09:20:32 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:20:32 INFO - mozversion application_vendor: Mozilla 09:20:32 INFO - mozversion application_version: 58.0a1 09:20:32 INFO - mozversion platform_buildid: 20170921152748 09:20:32 INFO - mozversion platform_changeset: b14c75b83d0226333b1240466ea9f07cfb206ff3 09:20:32 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:20:32 INFO - mozversion platform_version: 58.0a1 09:20:32 INFO - using testdate: 1506010832 09:20:32 INFO - actual date: 1506010832 09:20:32 INFO - starting webserver on 'localhost:53584' 09:20:32 INFO - SUITE-START | Running 2 tests 09:20:32 INFO - TEST-START | dromaeo_css 09:20:32 INFO - Initialising browser for dromaeo_css test... 09:20:32 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:53584/getInfo.html -profile /tmp/tmpN5kKDt/profile 09:20:32 INFO - TEST-INFO | started process 3600 (/builds/slave/test/build/application/firefox/firefox http://localhost:53584/getInfo.html) 09:20:41 INFO - TEST-INFO | 3600: exit 0 09:20:42 INFO - Browser initialized. 09:20:42 INFO - Running cycle 1/1 for dromaeo_css test... 09:20:42 INFO - Using env: {'DISPLAY': ':0', 09:20:42 INFO - 'HOME': '/home/cltbld', 09:20:42 INFO - 'JSGC_DISABLE_POISONING': '1', 09:20:42 INFO - 'LANG': 'en_US.UTF-8', 09:20:42 INFO - 'LANGUAGE': 'en_US:en', 09:20:42 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 09:20:42 INFO - 'LOGNAME': 'cltbld', 09:20:42 INFO - 'MAIL': '/var/mail/cltbld', 09:20:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:20:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:20:42 INFO - 'MOZ_CRASHREPORTER': '1', 09:20:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:42 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 09:20:42 INFO - 'MOZ_NO_REMOTE': '1', 09:20:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:20:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:20:42 INFO - 'NO_EM_RESTART': '1', 09:20:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:20:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:42 INFO - 'PWD': '/builds/slave/test', 09:20:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:20:42 INFO - 'RUST_BACKTRACE': 'full', 09:20:42 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 09:20:42 INFO - 'SHELL': '/bin/bash', 09:20:42 INFO - 'SHLVL': '1', 09:20:42 INFO - 'STYLO_FORCE_DISABLED': '1', 09:20:42 INFO - 'TERM': 'linux', 09:20:42 INFO - 'TMOUT': '86400', 09:20:42 INFO - 'USER': 'cltbld', 09:20:42 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1506010768.330791-388580899', 09:20:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:42 INFO - '_': '/tools/buildbot/bin/python'} 09:20:42 INFO - TEST-INFO | started process 3834 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpN5kKDt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 09:20:42 INFO - PID 3834 | 09:20:42 INFO - PID 3834 | (/builds/slave/test/build/application/firefox/firefox:3883): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 09:20:42 INFO - PID 3834 | 09:20:53 INFO - PID 3834 | RSS: Main: 154599424 09:20:53 INFO - PID 3834 | 09:23:50 INFO - PID 3834 | Cycle 1(1): loaded http://localhost:53584/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53584/tests/dromaeo/cssquery-ext.html) 09:23:51 INFO - PID 3834 | RSS: Main: 155238400 09:23:51 INFO - PID 3834 | 09:26:53 INFO - PID 3834 | Cycle 1(1): loaded http://localhost:53584/tests/dromaeo/cssquery-ext.html (next: http://localhost:53584/tests/dromaeo/cssquery-jquery.html) 09:26:54 INFO - PID 3834 | RSS: Main: 155635712 09:26:54 INFO - PID 3834 | 09:29:55 INFO - PID 3834 | Cycle 1(1): loaded http://localhost:53584/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53584/tests/dromaeo/cssquery-mootools.html) 09:29:56 INFO - PID 3834 | RSS: Main: 157421568 09:29:56 INFO - PID 3834 | 09:32:58 INFO - PID 3834 | Cycle 1(1): loaded http://localhost:53584/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53584/tests/dromaeo/cssquery-prototype.html) 09:32:58 INFO - PID 3834 | RSS: Main: 156086272 09:32:58 INFO - PID 3834 | 09:36:01 INFO - PID 3834 | Cycle 1(1): loaded http://localhost:53584/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53584/tests/dromaeo/cssquery-yui.html) 09:36:02 INFO - PID 3834 | RSS: Main: 157601792 09:36:02 INFO - PID 3834 | 09:39:04 INFO - PID 3834 | Cycle 1(1): loaded http://localhost:53584/tests/dromaeo/cssquery-yui.html (next: http://localhost:53584/tests/dromaeo/cssquery-dojo.html) 09:39:04 INFO - PID 3834 | RSS: Main: 158248960 09:39:04 INFO - PID 3834 | 09:39:04 INFO - PID 3834 | __start_tp_report 09:39:04 INFO - PID 3834 | _x_x_mozilla_page_load 09:39:04 INFO - PID 3834 | _x_x_mozilla_page_load_details 09:39:04 INFO - PID 3834 | |i|pagename|runs| 09:39:04 INFO - PID 3834 | |0;dojo.html;3181.459151944169;3198.2643991881873;3202.1994501374656;3205.5191721241827;3214.7910385824935;6256.374362563742;6410.839729006771;6454.935450645492;6458.612483250997;6460.676966151691;6352.396522330371;6363.840903977403;6371.10804487371;6384.265809431917;6417.390347916952;5813.854653633651;5822.621529600573;5851.502622277111;5854.707264636772;5929.792457263997;5830.941690583082;5915.526757859361;5964.13520039594;5966.105084237356;6006.579539432241;578.6620318445433;5909.793157239497;5914.467697907187;5963.284405871302;5992.700364981755;5800.24596802413;5806.332271788714;5819.73811178498;5952.523798096142;5984.431479009487;5854.385289544622;5866.73599688015;5938.940610593925;5944.613600115978;5952;6322.87354252917;6370.169545585908;6430.453411460032;6490.837729056811;6496.155499785045;6880.036794848726;6896.586204827727;6971.233164351917;6976.790696279069;6989.405900498464;6769.221539522969;6947.201071876749;6956.304369563054;7028.0863487746265;7038.260982596805;6340.841478963017;6354.777582784626;6372.7132279047555;6375.394337537927;6377.617342959391;7014.438844892396;7021.613811240431;7031.683574239171;7032.12098487689;7033.8944915826305;6745.59526428406;6790.388865002174;6833.077534532874;6868.313168683092;6869.553479023847;6791.932080679228;6792.08306878575;6863.794086177422;6875.5874647521305;6904.067950826675;6637.46900247979;6753.966230168818;6780.559263647847;6818.2159051708695;6906.240313565504;6937.68780404883;6938.5143039986715;6942.583444993215;6950.965245173843;6956.860862782716;5399.568034557226;5472.781088756485;5473.31583552056;5483.561315094783;5488;4618.56123668251;4673.649476289292;4685.835995740133;4742.644301677388;4767.022760334124;5881.882362352729;5884.7940322088525;5953.434423729739;5955.3151387590115;5959.433853783884;6696.765613203612;6829.863402731918;6917.13535808024;6989.545679530815;7009.9299007010295;5838.416158384128;5843.2403787507355;5871.706414679249;5909.8227053188475;5930.7924222652;5937.70311484424;5947.04847224442;5961.582689211714;5968.552358573124;5975.671338076448;6594.604323740591;6613.239477460057;6643;6667.633280169637;6698.698558564779;6798.354156355138;6822.624755638289;6889.689963951534;6937.89593156093;6941.861162776817;6492;6501.804945851632;6556.3443655634055;6568.770093046721;6583.604983700993;6679.833004174934;6699.497537684596;6822.283660215804;6823.727050918106;6880.862382752417;6881.41507971828;6899.689513971984;6969.58182509051;6980.092587963532;6987.196472405535;6615.834604134935;6647.6676166192465;6664.0670306158145;6682.732690692318;6765.729370825309;6531.575447595891;6621.503387246072;6640.601563906181;6653.1018312527185;6710.496712746662;6508.219013718384;6598.439132673777;6611.900821487778;6673.165854268216;6680.632565208765;6714.563553369016;6731.596104233761;6742.595444273359;6751.594904305757;6780.762673306411;6505.447037001908;6507.739690412331;6591.406773390418;6597.934020659924;6600.306967768507 09:39:04 INFO - PID 3834 | |1;ext.html;863.3740538109871;881.8060026794103;883.4125306671064;890.4123278636099;891.6477991193478;38519;42267.78866105669;42676.14647707044;42702;43093.35359969603;39100.21799564007;39352.803235983854;39467.80266098666;39487.21025579487;39657.80171099141;7174.139103307584;7237.601931893743;7306.926930730704;7752.534847909115;7944.483608565453;7801.960990195041;7908.090569584485;7916.366690664762;7959.2836644701965;7985.880211796828;7979.202079792032;7994.720184793533;8004.799880002988;8028.598570071502;8035.316998055172;7976.122626511079;8001;8005.839883202361;8006.67973281068;8009.479383840032;7897.2497612727275;7929.881051784228;7949.364050875916;7962.402819788539;7963.2833045025645;39184.41223381623;39276.41085383722;39283.60716392828;39313.21373572513;39618.60381396178;3491.4413693809124;3517.6834084932225;3528.541289632357;3529.347070791886;3552.147484603702;32381.352372952646;32517.83741081303;32694.67305326964;32698.836505817555;32843.6715632843;5188.558972487343;5190.8183213587345;5260.421353651095;5292.100342941709;5298;190632;190948;192273;192286;192497;43118.568814312086;43688.563114369084;49966.50033499691;50063.24905126426;50182.49817501851;52142;52806.20790688143;53081;53138.734306328995;53148.20277695838;14798.186099764402;14798.630034249014;14893.70212595742;14950.028248163835;14950.177740224175;11785.528578856749;11857.229280096766;11872.762544749057;11878.643640690792;11953.880461195276;14174;14232.715345693236;14232.928835355757;14350.49773257931;14587.927060364631;5514.476124768141;5576.9163462548095;5670.943290567042;5681.34664513578;5744.339400968858;1012.2155329619457;1033.3902997231519;1033.493588141805;1037.1339931157418;1049.7952899184586;23205.767942320697;23390.532189356116;23410.7658923412;23623.763762362156;23949.640755388682;1088.9945550272357;1100.2683215661655;1126.7859106769688;1134.6142311614092;1139.4701463819363;12156.270623762603;12366.886980171828;12423.503059877503;12437.067219958359;12603.495860165674;220416;221410;222023;222292;222372;55153;55375.723121384945;55389.44610553923;55572.72213638987;55731.442685573435;1417.0718179592384;1461.663817322022;1471.6909449015614;1475.3508456279203;1482.3306584259453;22147.88926055424;22821.31536053921;22909;23023.309300721005;23333.76666233316;38255.617443825206;38513;38519.614803851604;38577.22845543017;38664.42003370008;190875;192115;194384;195186;196694;31487.21281967969;31933.36133277275;34399;34771.13072173216;35741.285174296885;43645.345319820866;44137.33793993157;44139.337909932015;44565;44585.331220031076;32460.35079298448;32507.18732031718;32537.186570335933;32836.83581582077;32949.50575741414;31445;31465.528017079305;31860.681393185772;32003.519947200344;32133.35733285368;35148;35386.64613353936;35443.291134177685;35649.1087722809;35710.285794284486;31602.82358571424;31628;31909.521357179197;32064;32414.83792581022;23452.64821027652;23490.765092349542;23705.762942371046;23871.04515819348;24233.878830605736 09:39:04 INFO - PID 3834 | |2;jquery.html;578.725105574852;581.4766709961032;584.6141546579258;594.0969726016455;595.9463648271656;22160.445988850268;22638.20766273181;22877.542449151028;22882.427939301524;23041.4239644009;23361;24979.62530562043;25459.61810572843;26045.08842190524;26230.344241393974;6601.999999999988;6758.695858686347;6761.053452516651;6764.391204791567;6768.627725475097;6620.304867988864;6700.798976030727;6708.765193218238;6709.36261055199;6935.861282774342;7195.928040719605;7196.604186769726;7197.064381630381;7214.7114115435315;7253.7098516059295;7216.603086830222;7225.530340527849;7237.059182306319;7237.710491580357;7246.456515761339;6644.269130395653;6954.40887524561;6960.617166055865;6973.267806880306;6979.965100174518;30845.228869278224;31407;31454.89907853214;31461.528077078634;31468.055958321285;2048.5083579940856;2065.6694928811316;2068.255428045902;2068.834493240537;2071.295759441782;20439.284625038053;20604.690929636068;21105;21300.573988520144;21497.46256343588;2528.1657053172407;2545.350935511451;2599.038355808344;2606.5829467285143;2612.7648511634043;119784;126494;128440.35779821135;138232.30883845515;138861.3056934719;20409.795902041085;21025.579488410145;22340.88829555842;22508.324750257518;22788.31635050951;41812.372814407805;41887;41967.790161049;41980.79009604932;42161.789191053846;10876.510557024953;10930.398828064373;10935.28920620157;11049.944750276198;11096.1123110151;8947.776305592412;8975.23710484603;9004.909950900406;9104.726858194264;9119.04250053748;11665;11670.94164529172;11765.529378824922;11850.644480665595;11856.822147667792;3749.775013499199;3825.035597412028;4141.668666506733;4273.777635629517;4370.2570563004365;937.95310234488;942.7124726958343;973.6738192705523;973.6786860336072;989.8267803134422;19470.902645486683;19495.22019119248;19524.70712939307;19596.412107636792;20201.292954746514;983.8179936711731;1015.7663737340305;1034.3173505486343;1044.2011860926398;1044.4046544337316;10635.936406359302;10836.458177091114;10945.124390048777;10969.177311701655;11125.777484450266;480136;483800;489488;498344;500102;102972.48513757384;106157;108894.45552772186;109074;110418;1046.9371837689764;1091.9071878890384;1144.8168293073068;1158.530795028015;1191.92252503587;20788.792112078685;20789.272375466786;21097.050632721257;21150.576988460452;21180.68228976536;54770.452295476534;55592.44407555873;56263;57021.42978570161;57750.4224957745;67778.3222167772;68241;68453;68776;69015;20004.299849505198;20365.898170509052;20547.58904821925;20591;20651.58696826025;23251.651225231974;23601.29196124119;23680.763192367856;23838;23977.760222397552;18843.340483083026;18886.622267554845;19022.1440035196;19030.524236893634;19041.333553325567;16565.171741413124;16679.332826686797;16688.499345019667;17109.572260693083;17222.65554688874;17668.29326826964;18761.812381876553;18953;19168.329108481135;19269.518262043563;19852.90073549623;20181.59636807285;20222.090005949474;20257;20294.086766095857;18726.15732292023;18772.249110035445;18777.718334224723;19051.714224286923;19225.615487689887 09:39:04 INFO - PID 3834 | |3;mootools.html;1310.0894878059748;1357.9524716634915;1362.1282379277263;1362.4550179928028;1371.7462269480154;15169.848301516995;15824.68350632988;15833.44582939596;15866.52400427989;15881.841181588181;15531.68936621267;15644.843551564481;15707.136107514083;15712.528624141265;15714.607134821606;2819.1824370932404;2833.9372735224238;2866.9139925802156;2871.770258379325;2879.9136025919256;2808.0593001344573;2811;2835.2911772056987;2835.9149225523265;2839.034728192414;2829.462402143586;2832.900848470304;2846.658400991884;2848.1028476030087;2849.116773800118;2768.6400767900145;2772.8336299822076;2784.0951690700504;2786.1362977476947;2801.971980280212;2673.8529380884042;2678.6785585729835;2697.109953715269;2697.5009623219767;2698.730126987305;15033.699326013528;15095.622609434742;15116.924415377962;15145.394184232617;15295.923520382437;8152.755417337489;8474.067852536216;8491.490510569323;8499.957500212522;8516.616752246164;5329.147336426192;5480.232767412565;5623.606347555673;5828.708564571797;5833.2416785817995;1919.9040047997685;1950.2978927586057;1959.8334141597982;1994.840412766975;2007.9498012549657;24978.250652480456;25584.87207563969;25836.612450813253;26292.60561091604;27880.30299242515;7278.672459739324;7310.963445182846;7399.556026638311;7569.962150189324;7610.972518710014;20723.58552828935;20830.895845520674;20840.895795520926;20863.269785557433;20948;8358.874616880752;8394.874076888851;8400.663973440995;8409.075001749803;8434.451760635538;7269.63651817407;7571.545707257582;7593.924060759432;7650.693972241159;7680.270374314431;5591.692456914828;5808.5062769665055;5824.388439213906;5838.182654428383;5876.382979787061;1824.489143039951;1828.7988321284647;1862.3658907637541;1883.7645294338208;1893.5360836594848;885.8671199320024;902.6163880350824;907.6414816147717;910.8041771019263;917.0554329040965;8488.278496327757;8761;8856.202941735146;8865.64537418509;8905.154010369004;672.7342699633617;685.6845850908538;696.8153439338579;699.909011828459;706.5760543673755;4777.689450185727;4796.304535842283;4801.903961920742;4818.566329030404;4826.734529600905;20804.583908321747;22609.434764131027;22624.434389140402;22645.320640380814;22647.094116235494;21324.466888327916;21584.892075539523;22068.448288792588;22129.889350553465;22156.449048566446;9760.267979901393;10098.848517272247;11309.09527237819;11523.539058437736;11801.763964720658;8877.689280875138;8899.466032038099;8958.91041089607;9065.637374504946;9096.636134554808;17580.560485987953;18880.150393232612;19286.132124054733;19692.803071969098;19864.70202946928;19410.4176874694;19652.50868728293;19905.10427030758;20018.299359522345;20090.799092008892;11199.496022679163;11490.82763758561;11492.712682183012;11605.245659032473;11605.941970290094;13820.101693389897;13821.447142114203;13997.790033149715;13998.580042598738;14010.719785604435;11557.653270401901;11685.76628467443;11737.88262117368;11752.70618234551;12022.63932082039;11245.831312530156;11315.773684526428;11439.942800285946;11483.885161148282;11489.82765258505;9491.061893022055;9683.273754468584;9937.850932236166;9940.552675129782;9999.850002249827;6969.233384327618;7122.278090406454;7163.749268775777;7184;7247.746328878675;7207.495475316678;7266.636668166676;7300.525465844703;7400.000999864949;7494.5503269803985 09:39:04 INFO - PID 3834 | |4;prototype.html;509.68144909431606;531.0006290772378;537.7606964900621;539.7759929629199;540.2247774443675;6284.528660350475;6403.807885763429;6482.120185146302;6483.254425741041;6502.31725668805;6158.353372895848;6239.3465731581055;6257.937420625793;6282.277538083111;6309.873802523946;5204;5220.2430647556275;5225.399079105913;5239.633225674204;5263.578913686896;4869.537393947569;5093.770780314876;5188.844334669966;5199.298094757197;5221.198686453167;4994.225894986283;5025.623078269126;5054.349998001847;5065.392152941652;5083.085044691972;4987.055048531076;5013.122703526905;5023.547880690755;5042.722650254272;5060.51925067118;4431.161068156711;4478.820847166109;4528.728276303399;4539.909201815945;4567.954320456786;6204.441600255998;6251.937480625181;6293.779717709858;6309.305976342599;6323.52573556985;5808.59339846211;5820.476157145878;5831.9416805831825;5858.53131749459;5881.735321910524;6559.278479367265;6574.737010519573;6601.339866013408;6625.238097618787;6653.634050127241;4881.975590122062;4914.1817527514695;4946.703197808107;4949.515145456385;4973;6635.270120286765;6854.725810967555;6861.313868613099;6889.6919531956855;6928.515003949726;5023.14606516893;5033.169527028;5058.962912602908;5094.159463688524;5099.209622508517;5097.745112744348;5171.379434467888;5191.351081114861;5191.5846732261325;5196.506331898464;5769.480746732815;5770.855728606734;5776.913346299809;5817.970910145422;5843.152742852262;6694.230163531159;6740.191177058687;6755.1556055493065;6761.966190169018;6772;1776.8845025073588;1785.7053586158138;1794.1477798046085;1811.5652243461475;1814.9364772233173;1163.96508104757;1232.580922486359;1246.3830403950103;1248.9375531223402;1255.5731051442554;5734.311882574118;5734.713264336767;5754.7339585291165;5754.88490230193;5777.537796976232;6795.490338224653;6809;6824.761133360308;6826.283240259701;6841.939499377604;5643.194177863044;5675.489205971482;5699.401562835926;5713.428657134254;5723.7996670116345;3561.4479755637917;3568.6074531801482;3572.1783989682;3587.210813620999;3603.585587657453;6123.785667501616;6280.780172693934;6418.807435776934;6491.415772580491;6544.443722283564;6669.599824010478;6759.188897332253;6765.797026089225;6840.897386539206;6844.726210951506;6335.208098987627;6336.6831658416895;6453.741850325934;6456.578013652772;6497.4477169441125;6614.702338394687;6630.237522684953;6660.467162627075;6728.865422691617;6797.422219111431;6596.769113081019;6633.7678181265355;6687.76592819249;6754.797356079325;6773.62745049027;6453.096566480603;6492.675366231764;6522.15212022434;6525.804225873231;6566.671666416564;4929.507049295042;4981.128302547112;5013.623978201576;5013.623978201576;5031.371078615173;6522.673866306761;6637.535372523877;6681.799546013627;6724;6796.5143005616055;6437.517186210959;6446.226452825691;6463.612183269019;6479.384458476437;6563.540552161303;6422.229332480132;6463.289038205888;6491.285958544462;6542.934570654423;6612.437942774918;6362.331955144643;6408.743650253938;6459.418652321314;6466.450351719968;6503.382178693017;6390.3221133916095;6504.60972341661;6620.867582648417;6633.635150066792;6639.767608133692;6240.469560087444;6279.403456671609;6369.840753981188;6389.744410223539;6473.769983703081 09:39:04 INFO - PID 3834 | |5;yui.html;886.5655828643964;900.657750054979;933.3699752666948;936.8735220745201;938.1931538876565;19391.806081939176;20208.292709755162;20275.08762105705;20353.38939831804;20399.99999999998;16802.579935501588;16854.157292135376;17557.91221043893;18414.263429462804;18661.34685286015;968.0996673094037;982.9262805289596;987.6543209876558;989.1246247071358;989.8762654668167;982.9508524573779;986.2800155886207;986.8273052215869;987.2644879564734;998.0119681515284;1009.8535712321709;1043.8956104389576;1056.10758908722;1056.7146870345002;1058.1534772182224;1028.3367228137884;1042.6663467690341;1043.056034288962;1043.056034288966;1044.613493007592;727.3853593713304;749.636426333228;749.6401727170934;750.4934169435609;753.2994315286782;20606.27878024277;20694.275700350565;20747.896260518603;20827.062782174686;20865.269715560033;20678;21029.47426314339;21795.455113622127;21841.126354945784;21852.562948740935;17338.479845604525;17515.12424378776;17563.73654395185;17677.7348339775;17686;3764;3774.8678796242275;3784.413415920537;3787.072167318997;3790.6019867913747;136679;137968;138356;138789.99999999898;141911;16829.663406731797;16943.661126777395;17201.225944832513;17210.31158753636;17237.655246895243;31641.52537711936;32018.679813202034;32038.519422208687;32503.837480812446;32670.83664581662;8894.110588941054;9033.277337812959;9049.547522623843;9053.909460905306;9061.909380906107;4283.186194623012;4425.070735145656;4491.416115904912;4514.345419914094;4529.750863702528;5459.754311056012;5588.832335029955;5603.047481928082;5614.831555053355;5621.241132447068;1026.8049070676548;1059.2426415113232;1067.178272730009;1075.7203127186988;1076.8707755069443;676.0670275020441;683.9316068393221;701.4598758955576;704.6124631452783;706.5619316023996;11592.826107608393;11766.352850593299;11977.880221197676;12131;12274.079444041732;670.5741853922794;680.8536164724608;693.9722411103601;699.3426179391356;707.6320313436984;5196.324477817935;5223.4515375884985;5261.158214685632;5296.3379577552805;5345.412004679482;112706;114251;115213.42393288147;116469.41765291289;117890.41054794671;98254.5087274559;100118;100880.49559752301;102188;103004.48497757463;85150;87903;90469;90474.99999999869;90611.09388906027;9706.708798735766;9810.803783924424;9934.403935763878;10203.28576999603;10205.38767673942;42435.363469548596;44004.55995440004;44490.11019779651;44750.3287450695;44762.3285650722;56552.73789048392;57126.428735712114;57390.426095738505;57787;58845.411545885705;14476.348564314421;15290;15499.225038748244;15610.297536611108;15731.528054158394;18258.72611910849;18309.3591724289;18373.54066148357;18391.540211494284;18554.721679174552;15367.077975321516;15396.538103856903;15610.609734756721;15669;15838.52484425469;14453.566393008226;14659.340329684976;14794.334254958338;14871.330790114254;14891.329890154753;14075.648108797363;14138.78791818103;14328.713425731636;14359.210243436712;14525.564233073024;12545.87454125447;12758.936205318914;12811.743765124458;12835.807462888251;12921.870781292442;11373.488193031168;11467.483963221508;11552;11599.304041757521;11602.129840261845 09:39:04 INFO - PID 3834 | __end_tp_report 09:39:04 INFO - PID 3834 | __start_cc_report 09:39:04 INFO - PID 3834 | _x_x_mozilla_cycle_collect,281 09:39:04 INFO - PID 3834 | __end_cc_report 09:39:04 INFO - PID 3834 | __startTimestamp1506011944323__endTimestamp 09:39:04 INFO - PID 3834 | 09:39:04 INFO - PID 3834 | ------- Summary: start ------- 09:39:04 INFO - PID 3834 | Number of tests: 6 09:39:04 INFO - PID 3834 | 09:39:04 INFO - PID 3834 | [#0] dojo.html Cycles:165 Average:6283.48 Median:6568.77 stddev:880.64 (13.4%) stddev-sans-first:849.05 09:39:04 INFO - PID 3834 | Values: 3181.5 3198.3 3202.2 3205.5 3214.8 6256.4 6410.8 6454.9 6458.6 6460.7 6352.4 6363.8 6371.1 6384.3 6417.4 5813.9 5822.6 5851.5 5854.7 5929.8 5830.9 5915.5 5964.1 5966.1 6006.6 578.7 5909.8 5914.5 5963.3 5992.7 5800.2 5806.3 5819.7 5952.5 5984.4 5854.4 5866.7 5938.9 5944.6 5952.0 6322.9 6370.2 6430.5 6490.8 6496.2 6880.0 6896.6 6971.2 6976.8 6989.4 6769.2 6947.2 6956.3 7028.1 7038.3 6340.8 6354.8 6372.7 6375.4 6377.6 7014.4 7021.6 7031.7 7032.1 7033.9 6745.6 6790.4 6833.1 6868.3 6869.6 6791.9 6792.1 6863.8 6875.6 6904.1 6637.5 6754.0 6780.6 6818.2 6906.2 6937.7 6938.5 6942.6 6951.0 6956.9 5399.6 5472.8 5473.3 5483.6 5488.0 4618.6 4673.6 4685.8 4742.6 4767.0 5881.9 5884.8 5953.4 5955.3 5959.4 6696.8 6829.9 6917.1 6989.5 7009.9 5838.4 5843.2 5871.7 5909.8 5930.8 5937.7 5947.0 5961.6 5968.6 5975.7 6594.6 6613.2 6643.0 6667.6 6698.7 6798.4 6822.6 6889.7 6937.9 6941.9 6492.0 6501.8 6556.3 6568.8 6583.6 6679.8 6699.5 6822.3 6823.7 6880.9 6881.4 6899.7 6969.6 6980.1 6987.2 6615.8 6647.7 6664.1 6682.7 6765.7 6531.6 6621.5 6640.6 6653.1 6710.5 6508.2 6598.4 6611.9 6673.2 6680.6 6714.6 6731.6 6742.6 6751.6 6780.8 6505.4 6507.7 6591.4 6597.9 6600.3 09:39:04 INFO - PID 3834 | 09:39:04 INFO - PID 3834 | [#1] ext.html Cycles:180 Average:37396.14 Median:19332.84 stddev:52552.58 (271.8%) stddev-sans-first:52628.41 09:39:04 INFO - PID 3834 | Values: 863.4 881.8 883.4 890.4 891.6 38519.0 42267.8 42676.1 42702.0 43093.4 39100.2 39352.8 39467.8 39487.2 39657.8 7174.1 7237.6 7306.9 7752.5 7944.5 7802.0 7908.1 7916.4 7959.3 7985.9 7979.2 7994.7 8004.8 8028.6 8035.3 7976.1 8001.0 8005.8 8006.7 8009.5 7897.2 7929.9 7949.4 7962.4 7963.3 39184.4 39276.4 39283.6 39313.2 39618.6 3491.4 3517.7 3528.5 3529.3 3552.1 32381.4 32517.8 32694.7 32698.8 32843.7 5188.6 5190.8 5260.4 5292.1 5298.0 190632.0 190948.0 192273.0 192286.0 192497.0 43118.6 43688.6 49966.5 50063.2 50182.5 52142.0 52806.2 53081.0 53138.7 53148.2 14798.2 14798.6 14893.7 14950.0 14950.2 11785.5 11857.2 11872.8 11878.6 11953.9 14174.0 14232.7 14232.9 14350.5 14587.9 5514.5 5576.9 5670.9 5681.3 5744.3 1012.2 1033.4 1033.5 1037.1 1049.8 23205.8 23390.5 23410.8 23623.8 23949.6 1089.0 1100.3 1126.8 1134.6 1139.5 12156.3 12366.9 12423.5 12437.1 12603.5 220416.0 221410.0 222023.0 222292.0 222372.0 55153.0 55375.7 55389.4 55572.7 55731.4 1417.1 1461.7 1471.7 1475.4 1482.3 22147.9 22821.3 22909.0 23023.3 23333.8 38255.6 38513.0 38519.6 38577.2 38664.4 190875.0 192115.0 194384.0 195186.0 196694.0 31487.2 31933.4 34399.0 34771.1 35741.3 43645.3 44137.3 44139.3 44565.0 44585.3 32460.4 32507.2 32537.2 32836.8 32949.5 31445.0 31465.5 31860.7 32003.5 32133.4 35148.0 35386.6 35443.3 35649.1 35710.3 31602.8 31628.0 31909.5 32064.0 32414.8 23452.6 23490.8 23705.8 23871.0 24233.9 09:39:04 INFO - PID 3834 | 09:39:04 INFO - PID 3834 | [#2] jquery.html Cycles:180 Average:35703.26 Median:22832.93 stddev:81914.17 (358.8%) stddev-sans-first:82101.51 09:39:04 INFO - PID 3834 | Values: 578.7 581.5 584.6 594.1 595.9 22160.4 22638.2 22877.5 22882.4 23041.4 23361.0 24979.6 25459.6 26045.1 26230.3 6602.0 6758.7 6761.1 6764.4 6768.6 6620.3 6700.8 6708.8 6709.4 6935.9 7195.9 7196.6 7197.1 7214.7 7253.7 7216.6 7225.5 7237.1 7237.7 7246.5 6644.3 6954.4 6960.6 6973.3 6980.0 30845.2 31407.0 31454.9 31461.5 31468.1 2048.5 2065.7 2068.3 2068.8 2071.3 20439.3 20604.7 21105.0 21300.6 21497.5 2528.2 2545.4 2599.0 2606.6 2612.8 119784.0 126494.0 128440.4 138232.3 138861.3 20409.8 21025.6 22340.9 22508.3 22788.3 41812.4 41887.0 41967.8 41980.8 42161.8 10876.5 10930.4 10935.3 11049.9 11096.1 8947.8 8975.2 9004.9 9104.7 9119.0 11665.0 11670.9 11765.5 11850.6 11856.8 3749.8 3825.0 4141.7 4273.8 4370.3 938.0 942.7 973.7 973.7 989.8 19470.9 19495.2 19524.7 19596.4 20201.3 983.8 1015.8 1034.3 1044.2 1044.4 10635.9 10836.5 10945.1 10969.2 11125.8 480136.0 483800.0 489488.0 498344.0 500102.0 102972.5 106157.0 108894.5 109074.0 110418.0 1046.9 1091.9 1144.8 1158.5 1191.9 20788.8 20789.3 21097.1 21150.6 21180.7 54770.5 55592.4 56263.0 57021.4 57750.4 67778.3 68241.0 68453.0 68776.0 69015.0 20004.3 20365.9 20547.6 20591.0 20651.6 23251.7 23601.3 23680.8 23838.0 23977.8 18843.3 18886.6 19022.1 19030.5 19041.3 16565.2 16679.3 16688.5 17109.6 17222.7 17668.3 18761.8 18953.0 19168.3 19269.5 19852.9 20181.6 20222.1 20257.0 20294.1 18726.2 18772.2 18777.7 19051.7 19225.6 09:39:04 INFO - PID 3834 | 09:39:04 INFO - PID 3834 | [#3] mootools.html Cycles:180 Average:9631.94 Median:2785.12 stddev:6877.47 (246.9%) stddev-sans-first:6868.34 09:39:04 INFO - PID 3834 | Values: 1310.1 1358.0 1362.1 1362.5 1371.7 15169.8 15824.7 15833.4 15866.5 15881.8 15531.7 15644.8 15707.1 15712.5 15714.6 2819.2 2833.9 2866.9 2871.8 2879.9 2808.1 2811.0 2835.3 2835.9 2839.0 2829.5 2832.9 2846.7 2848.1 2849.1 2768.6 2772.8 2784.1 2786.1 2802.0 2673.9 2678.7 2697.1 2697.5 2698.7 15033.7 15095.6 15116.9 15145.4 15295.9 8152.8 8474.1 8491.5 8500.0 8516.6 5329.1 5480.2 5623.6 5828.7 5833.2 1919.9 1950.3 1959.8 1994.8 2007.9 24978.3 25584.9 25836.6 26292.6 27880.3 7278.7 7311.0 7399.6 7570.0 7611.0 20723.6 20830.9 20840.9 20863.3 20948.0 8358.9 8394.9 8400.7 8409.1 8434.5 7269.6 7571.5 7593.9 7650.7 7680.3 5591.7 5808.5 5824.4 5838.2 5876.4 1824.5 1828.8 1862.4 1883.8 1893.5 885.9 902.6 907.6 910.8 917.1 8488.3 8761.0 8856.2 8865.6 8905.2 672.7 685.7 696.8 699.9 706.6 4777.7 4796.3 4801.9 4818.6 4826.7 20804.6 22609.4 22624.4 22645.3 22647.1 21324.5 21584.9 22068.4 22129.9 22156.4 9760.3 10098.8 11309.1 11523.5 11801.8 8877.7 8899.5 8958.9 9065.6 9096.6 17580.6 18880.2 19286.1 19692.8 19864.7 19410.4 19652.5 19905.1 20018.3 20090.8 11199.5 11490.8 11492.7 11605.2 11605.9 13820.1 13821.4 13997.8 13998.6 14010.7 11557.7 11685.8 11737.9 11752.7 12022.6 11245.8 11315.8 11439.9 11483.9 11489.8 9491.1 9683.3 9937.9 9940.6 9999.9 6969.2 7122.3 7163.7 7184.0 7247.7 7207.5 7266.6 7300.5 7400.0 7494.6 09:39:04 INFO - PID 3834 | 09:39:04 INFO - PID 3834 | [#4] prototype.html Cycles:180 Average:5547.58 Median:6254.94 stddev:1537.75 (24.6%) stddev-sans-first:1494.85 09:39:04 INFO - PID 3834 | Values: 509.7 531.0 537.8 539.8 540.2 6284.5 6403.8 6482.1 6483.3 6502.3 6158.4 6239.3 6257.9 6282.3 6309.9 5204.0 5220.2 5225.4 5239.6 5263.6 4869.5 5093.8 5188.8 5199.3 5221.2 4994.2 5025.6 5054.3 5065.4 5083.1 4987.1 5013.1 5023.5 5042.7 5060.5 4431.2 4478.8 4528.7 4539.9 4568.0 6204.4 6251.9 6293.8 6309.3 6323.5 5808.6 5820.5 5831.9 5858.5 5881.7 6559.3 6574.7 6601.3 6625.2 6653.6 4882.0 4914.2 4946.7 4949.5 4973.0 6635.3 6854.7 6861.3 6889.7 6928.5 5023.1 5033.2 5059.0 5094.2 5099.2 5097.7 5171.4 5191.4 5191.6 5196.5 5769.5 5770.9 5776.9 5818.0 5843.2 6694.2 6740.2 6755.2 6762.0 6772.0 1776.9 1785.7 1794.1 1811.6 1814.9 1164.0 1232.6 1246.4 1248.9 1255.6 5734.3 5734.7 5754.7 5754.9 5777.5 6795.5 6809.0 6824.8 6826.3 6841.9 5643.2 5675.5 5699.4 5713.4 5723.8 3561.4 3568.6 3572.2 3587.2 3603.6 6123.8 6280.8 6418.8 6491.4 6544.4 6669.6 6759.2 6765.8 6840.9 6844.7 6335.2 6336.7 6453.7 6456.6 6497.4 6614.7 6630.2 6660.5 6728.9 6797.4 6596.8 6633.8 6687.8 6754.8 6773.6 6453.1 6492.7 6522.2 6525.8 6566.7 4929.5 4981.1 5013.6 5013.6 5031.4 6522.7 6637.5 6681.8 6724.0 6796.5 6437.5 6446.2 6463.6 6479.4 6563.5 6422.2 6463.3 6491.3 6542.9 6612.4 6362.3 6408.7 6459.4 6466.5 6503.4 6390.3 6504.6 6620.9 6633.6 6639.8 6240.5 6279.4 6369.8 6389.7 6473.8 09:39:04 INFO - PID 3834 | 09:39:04 INFO - PID 3834 | [#5] yui.html Cycles:180 Average:23695.57 Median:20503.14 stddev:33794.71 (164.8%) stddev-sans-first:33846.11 09:39:04 INFO - PID 3834 | Values: 886.6 900.7 933.4 936.9 938.2 19391.8 20208.3 20275.1 20353.4 20400.0 16802.6 16854.2 17557.9 18414.3 18661.3 968.1 982.9 987.7 989.1 989.9 983.0 986.3 986.8 987.3 998.0 1009.9 1043.9 1056.1 1056.7 1058.2 1028.3 1042.7 1043.1 1043.1 1044.6 727.4 749.6 749.6 750.5 753.3 20606.3 20694.3 20747.9 20827.1 20865.3 20678.0 21029.5 21795.5 21841.1 21852.6 17338.5 17515.1 17563.7 17677.7 17686.0 3764.0 3774.9 3784.4 3787.1 3790.6 136679.0 137968.0 138356.0 138790.0 141911.0 16829.7 16943.7 17201.2 17210.3 17237.7 31641.5 32018.7 32038.5 32503.8 32670.8 8894.1 9033.3 9049.5 9053.9 9061.9 4283.2 4425.1 4491.4 4514.3 4529.8 5459.8 5588.8 5603.0 5614.8 5621.2 1026.8 1059.2 1067.2 1075.7 1076.9 676.1 683.9 701.5 704.6 706.6 11592.8 11766.4 11977.9 12131.0 12274.1 670.6 680.9 694.0 699.3 707.6 5196.3 5223.5 5261.2 5296.3 5345.4 112706.0 114251.0 115213.4 116469.4 117890.4 98254.5 100118.0 100880.5 102188.0 103004.5 85150.0 87903.0 90469.0 90475.0 90611.1 9706.7 9810.8 9934.4 10203.3 10205.4 42435.4 44004.6 44490.1 44750.3 44762.3 56552.7 57126.4 57390.4 57787.0 58845.4 14476.3 15290.0 15499.2 15610.3 15731.5 18258.7 18309.4 18373.5 18391.5 18554.7 15367.1 15396.5 15610.6 15669.0 15838.5 14453.6 14659.3 14794.3 14871.3 14891.3 14075.6 14138.8 14328.7 14359.2 14525.6 12545.9 12758.9 12811.7 12835.8 12921.9 11373.5 11467.5 11552.0 11599.3 11602.1 09:39:04 INFO - PID 3834 | -------- Summary: end -------- 09:39:04 INFO - PID 3834 | 09:39:04 INFO - TEST-INFO | 3834: exit 0 09:39:05 INFO - TEST-OK | dromaeo_css | took 1112240ms 09:39:05 INFO - TEST-START | kraken 09:39:05 INFO - Initialising browser for kraken test... 09:39:05 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:53584/getInfo.html -profile /tmp/tmpYqEyXz/profile 09:39:05 INFO - TEST-INFO | started process 4197 (/builds/slave/test/build/application/firefox/firefox http://localhost:53584/getInfo.html) 09:39:10 INFO - TEST-INFO | 4197: exit 0 09:39:10 INFO - Browser initialized. 09:39:10 INFO - Running cycle 1/1 for kraken test... 09:39:10 INFO - Using env: {'DISPLAY': ':0', 09:39:10 INFO - 'HOME': '/home/cltbld', 09:39:10 INFO - 'JSGC_DISABLE_POISONING': '1', 09:39:10 INFO - 'LANG': 'en_US.UTF-8', 09:39:10 INFO - 'LANGUAGE': 'en_US:en', 09:39:10 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 09:39:10 INFO - 'LOGNAME': 'cltbld', 09:39:10 INFO - 'MAIL': '/var/mail/cltbld', 09:39:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:39:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:39:10 INFO - 'MOZ_CRASHREPORTER': '1', 09:39:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:10 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 09:39:10 INFO - 'MOZ_NO_REMOTE': '1', 09:39:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:39:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:39:10 INFO - 'NO_EM_RESTART': '1', 09:39:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:39:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:10 INFO - 'PWD': '/builds/slave/test', 09:39:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:39:10 INFO - 'RUST_BACKTRACE': 'full', 09:39:10 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 09:39:10 INFO - 'SHELL': '/bin/bash', 09:39:10 INFO - 'SHLVL': '1', 09:39:10 INFO - 'STYLO_FORCE_DISABLED': '1', 09:39:10 INFO - 'TERM': 'linux', 09:39:10 INFO - 'TMOUT': '86400', 09:39:10 INFO - 'USER': 'cltbld', 09:39:10 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1506010768.330791-388580899', 09:39:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:10 INFO - '_': '/tools/buildbot/bin/python'} 09:39:10 INFO - TEST-INFO | started process 4435 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYqEyXz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 09:39:11 INFO - PID 4435 | 09:39:11 INFO - PID 4435 | (/builds/slave/test/build/application/firefox/firefox:4484): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 09:39:11 INFO - PID 4435 | 09:39:21 INFO - PID 4435 | RSS: Main: 154775552 09:39:21 INFO - PID 4435 | 09:39:24 INFO - PID 4435 | Cycle 1(1): loaded http://localhost:53584/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53584/tests/kraken/driver.html?testName=audio-beat-detection) 09:39:25 INFO - PID 4435 | RSS: Main: 159657984 09:39:25 INFO - PID 4435 | 09:39:28 INFO - PID 4435 | Cycle 1(1): loaded http://localhost:53584/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53584/tests/kraken/driver.html?testName=audio-dft) 09:39:28 INFO - PID 4435 | RSS: Main: 160178176 09:39:28 INFO - PID 4435 | 09:39:31 INFO - PID 4435 | Cycle 1(1): loaded http://localhost:53584/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53584/tests/kraken/driver.html?testName=audio-fft) 09:39:32 INFO - PID 4435 | RSS: Main: 156614656 09:39:32 INFO - PID 4435 | 09:39:34 INFO - PID 4435 | Cycle 1(1): loaded http://localhost:53584/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53584/tests/kraken/driver.html?testName=audio-oscillator) 09:39:34 INFO - PID 4435 | RSS: Main: 157274112 09:39:35 INFO - PID 4435 | 09:39:37 INFO - PID 4435 | Cycle 1(1): loaded http://localhost:53584/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53584/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:39:37 INFO - PID 4435 | RSS: Main: 157417472 09:39:37 INFO - PID 4435 | 09:39:40 INFO - PID 4435 | Cycle 1(1): loaded http://localhost:53584/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53584/tests/kraken/driver.html?testName=imaging-darkroom) 09:39:41 INFO - PID 4435 | RSS: Main: 159891456 09:39:41 INFO - PID 4435 | 09:39:45 INFO - PID 4435 | Cycle 1(1): loaded http://localhost:53584/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53584/tests/kraken/driver.html?testName=imaging-desaturate) 09:39:45 INFO - PID 4435 | RSS: Main: 159629312 09:39:45 INFO - PID 4435 | 09:39:48 INFO - PID 4435 | Cycle 1(1): loaded http://localhost:53584/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53584/tests/kraken/driver.html?testName=json-parse-financial) 09:39:49 INFO - PID 4435 | RSS: Main: 159735808 09:39:49 INFO - PID 4435 | 09:39:51 INFO - PID 4435 | Cycle 1(1): loaded http://localhost:53584/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53584/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:39:51 INFO - PID 4435 | RSS: Main: 159731712 09:39:51 INFO - PID 4435 | 09:39:53 INFO - PID 4435 | Cycle 1(1): loaded http://localhost:53584/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53584/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:39:53 INFO - PID 4435 | RSS: Main: 159588352 09:39:53 INFO - PID 4435 | 09:39:55 INFO - PID 4435 | Cycle 1(1): loaded http://localhost:53584/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53584/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:39:56 INFO - PID 4435 | RSS: Main: 157401088 09:39:56 INFO - PID 4435 | 09:39:59 INFO - PID 4435 | Cycle 1(1): loaded http://localhost:53584/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53584/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:39:59 INFO - PID 4435 | RSS: Main: 157499392 09:39:59 INFO - PID 4435 | 09:40:02 INFO - PID 4435 | Cycle 1(1): loaded http://localhost:53584/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53584/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:40:03 INFO - PID 4435 | RSS: Main: 157679616 09:40:03 INFO - PID 4435 | 09:40:05 INFO - PID 4435 | Cycle 1(1): loaded http://localhost:53584/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53584/tests/kraken/driver.html?testName=ai-astar) 09:40:05 INFO - PID 4435 | RSS: Main: 158781440 09:40:05 INFO - PID 4435 | 09:40:05 INFO - PID 4435 | __start_tp_report 09:40:05 INFO - PID 4435 | _x_x_mozilla_page_load 09:40:05 INFO - PID 4435 | _x_x_mozilla_page_load_details 09:40:05 INFO - PID 4435 | |i|pagename|runs| 09:40:05 INFO - PID 4435 | |0;ai-astar;107;107;105;107;107;107;108;107;107;106 09:40:05 INFO - PID 4435 | |1;audio-beat-detection;117;118;117;120;144;118;121;145;117;142 09:40:05 INFO - PID 4435 | |2;audio-dft;164;163;164;162;162;163;165;167;167;166 09:40:05 INFO - PID 4435 | |3;audio-fft;76;74;74;73;73;76;75;74;79;74 09:40:05 INFO - PID 4435 | |4;audio-oscillator;80;81;79;78;78;80;79;79;78;79 09:40:05 INFO - PID 4435 | |5;imaging-gaussian-blur;117;113;113;117;114;115;114;115;114;114 09:40:05 INFO - PID 4435 | |6;imaging-darkroom;148;148;147;149;149;149;149;147;149;148 09:40:05 INFO - PID 4435 | |7;imaging-desaturate;94;95;94;94;93;95;94;94;93;95 09:40:05 INFO - PID 4435 | |8;json-parse-financial;52;52;54;53;56;53;52;56;53;52 09:40:05 INFO - PID 4435 | |9;json-stringify-tinderbox;42;43;42;38;39;39;39;39;38;41 09:40:05 INFO - PID 4435 | |10;stanford-crypto-aes;73;73;74;77;73;76;82;74;77;77 09:40:05 INFO - PID 4435 | |11;stanford-crypto-ccm;118;119;111;114;116;116;115;108;116;115 09:40:05 INFO - PID 4435 | |12;stanford-crypto-pbkdf2;180;172;181;173;168;175;173;173;170;171 09:40:05 INFO - PID 4435 | |13;stanford-crypto-sha256-iterative;69;66;67;65;67;68;66;68;65;70 09:40:05 INFO - PID 4435 | __end_tp_report 09:40:05 INFO - PID 4435 | __start_cc_report 09:40:05 INFO - PID 4435 | _x_x_mozilla_cycle_collect,776 09:40:05 INFO - PID 4435 | __end_cc_report 09:40:05 INFO - PID 4435 | __startTimestamp1506012005390__endTimestamp 09:40:05 INFO - PID 4435 | 09:40:05 INFO - PID 4435 | ------- Summary: start ------- 09:40:05 INFO - PID 4435 | Number of tests: 14 09:40:05 INFO - PID 4435 | 09:40:05 INFO - PID 4435 | [#0] ai-astar Cycles:10 Average:106.80 Median:107.00 stddev:0.79 (0.7%) stddev-sans-first:0.83 09:40:05 INFO - PID 4435 | Values: 107.0 107.0 105.0 107.0 107.0 107.0 108.0 107.0 107.0 106.0 09:40:05 INFO - PID 4435 | 09:40:05 INFO - PID 4435 | [#1] audio-beat-detection Cycles:10 Average:125.90 Median:120.50 stddev:12.35 (10.2%) stddev-sans-first:12.67 09:40:05 INFO - PID 4435 | Values: 117.0 118.0 117.0 120.0 144.0 118.0 121.0 145.0 117.0 142.0 09:40:05 INFO - PID 4435 | 09:40:05 INFO - PID 4435 | [#2] audio-dft Cycles:10 Average:164.30 Median:164.50 stddev:1.89 (1.1%) stddev-sans-first:2.00 09:40:05 INFO - PID 4435 | Values: 164.0 163.0 164.0 162.0 162.0 163.0 165.0 167.0 167.0 166.0 09:40:05 INFO - PID 4435 | 09:40:05 INFO - PID 4435 | [#3] audio-fft Cycles:10 Average:74.80 Median:74.50 stddev:1.81 (2.4%) stddev-sans-first:1.87 09:40:05 INFO - PID 4435 | Values: 76.0 74.0 74.0 73.0 73.0 76.0 75.0 74.0 79.0 74.0 09:40:05 INFO - PID 4435 | 09:40:05 INFO - PID 4435 | [#4] audio-oscillator Cycles:10 Average:79.10 Median:79.00 stddev:0.99 (1.3%) stddev-sans-first:1.00 09:40:05 INFO - PID 4435 | Values: 80.0 81.0 79.0 78.0 78.0 80.0 79.0 79.0 78.0 79.0 09:40:05 INFO - PID 4435 | 09:40:05 INFO - PID 4435 | [#5] imaging-gaussian-blur Cycles:10 Average:114.60 Median:114.50 stddev:1.43 (1.2%) stddev-sans-first:1.22 09:40:05 INFO - PID 4435 | Values: 117.0 113.0 113.0 117.0 114.0 115.0 114.0 115.0 114.0 114.0 09:40:05 INFO - PID 4435 | 09:40:05 INFO - PID 4435 | [#6] imaging-darkroom Cycles:10 Average:148.30 Median:149.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 09:40:05 INFO - PID 4435 | Values: 148.0 148.0 147.0 149.0 149.0 149.0 149.0 147.0 149.0 148.0 09:40:05 INFO - PID 4435 | 09:40:05 INFO - PID 4435 | [#7] imaging-desaturate Cycles:10 Average:94.10 Median:94.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 09:40:05 INFO - PID 4435 | Values: 94.0 95.0 94.0 94.0 93.0 95.0 94.0 94.0 93.0 95.0 09:40:05 INFO - PID 4435 | 09:40:05 INFO - PID 4435 | [#8] json-parse-financial Cycles:10 Average:53.30 Median:53.00 stddev:1.57 (3.0%) stddev-sans-first:1.59 09:40:05 INFO - PID 4435 | Values: 52.0 52.0 54.0 53.0 56.0 53.0 52.0 56.0 53.0 52.0 09:40:05 INFO - PID 4435 | 09:40:05 INFO - PID 4435 | [#9] json-stringify-tinderbox Cycles:10 Average:40.00 Median:40.00 stddev:1.83 (4.6%) stddev-sans-first:1.79 09:40:05 INFO - PID 4435 | Values: 42.0 43.0 42.0 38.0 39.0 39.0 39.0 39.0 38.0 41.0 09:40:05 INFO - PID 4435 | 09:40:05 INFO - PID 4435 | [#10] stanford-crypto-aes Cycles:10 Average:75.60 Median:76.50 stddev:2.84 (3.7%) stddev-sans-first:2.85 09:40:05 INFO - PID 4435 | Values: 73.0 73.0 74.0 77.0 73.0 76.0 82.0 74.0 77.0 77.0 09:40:05 INFO - PID 4435 | 09:40:05 INFO - PID 4435 | [#11] stanford-crypto-ccm Cycles:10 Average:114.80 Median:116.00 stddev:3.22 (2.8%) stddev-sans-first:3.21 09:40:05 INFO - PID 4435 | Values: 118.0 119.0 111.0 114.0 116.0 116.0 115.0 108.0 116.0 115.0 09:40:05 INFO - PID 4435 | 09:40:05 INFO - PID 4435 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.60 Median:173.00 stddev:4.12 (2.4%) stddev-sans-first:3.66 09:40:05 INFO - PID 4435 | Values: 180.0 172.0 181.0 173.0 168.0 175.0 173.0 173.0 170.0 171.0 09:40:05 INFO - PID 4435 | 09:40:05 INFO - PID 4435 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.50 stddev:1.66 (2.5%) stddev-sans-first:1.62 09:40:05 INFO - PID 4435 | Values: 69.0 66.0 67.0 65.0 67.0 68.0 66.0 68.0 65.0 70.0 09:40:05 INFO - PID 4435 | -------- Summary: end -------- 09:40:05 INFO - PID 4435 | 09:40:05 INFO - PID 4435 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 09:40:06 INFO - TEST-INFO | 4435: exit 0 09:40:06 INFO - TEST-OK | kraken | took 61044ms 09:40:06 INFO - SUITE-END | took 1173s 09:40:06 INFO - Completed test suite (00:19:33) 09:40:06 INFO - javascript benchmark 09:40:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8692.905863474934, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3181.459151944169, 3198.2643991881873, 3202.1994501374656, 3205.5191721241827, 3214.7910385824935, 6256.374362563742, 6410.839729006771, 6454.935450645492, 6458.612483250997, 6460.676966151691, 6352.396522330371, 6363.840903977403, 6371.10804487371, 6384.265809431917, 6417.390347916952, 5813.854653633651, 5822.621529600573, 5851.502622277111, 5854.707264636772, 5929.792457263997, 5830.941690583082, 5915.526757859361, 5964.13520039594, 5966.105084237356, 6006.579539432241, 578.6620318445433, 5909.793157239497, 5914.467697907187, 5963.284405871302, 5992.700364981755, 5800.24596802413, 5806.332271788714, 5819.73811178498, 5952.523798096142, 5984.431479009487, 5854.385289544622, 5866.73599688015, 5938.940610593925, 5944.613600115978, 5952.0, 6322.87354252917, 6370.169545585908, 6430.453411460032, 6490.837729056811, 6496.155499785045, 6880.036794848726, 6896.586204827727, 6971.233164351917, 6976.790696279069, 6989.405900498464, 6769.221539522969, 6947.201071876749, 6956.304369563054, 7028.0863487746265, 7038.260982596805, 6340.841478963017, 6354.777582784626, 6372.7132279047555, 6375.394337537927, 6377.617342959391, 7014.438844892396, 7021.613811240431, 7031.683574239171, 7032.12098487689, 7033.8944915826305, 6745.59526428406, 6790.388865002174, 6833.077534532874, 6868.313168683092, 6869.553479023847, 6791.932080679228, 6792.08306878575, 6863.794086177422, 6875.5874647521305, 6904.067950826675, 6637.46900247979, 6753.966230168818, 6780.559263647847, 6818.2159051708695, 6906.240313565504, 6937.68780404883, 6938.5143039986715, 6942.583444993215, 6950.965245173843, 6956.860862782716, 5399.568034557226, 5472.781088756485, 5473.31583552056, 5483.561315094783, 5488.0, 4618.56123668251, 4673.649476289292, 4685.835995740133, 4742.644301677388, 4767.022760334124, 5881.882362352729, 5884.7940322088525, 5953.434423729739, 5955.3151387590115, 5959.433853783884, 6696.765613203612, 6829.863402731918, 6917.13535808024, 6989.545679530815, 7009.9299007010295, 5838.416158384128, 5843.2403787507355, 5871.706414679249, 5909.8227053188475, 5930.7924222652, 5937.70311484424, 5947.04847224442, 5961.582689211714, 5968.552358573124, 5975.671338076448, 6594.604323740591, 6613.239477460057, 6643.0, 6667.633280169637, 6698.698558564779, 6798.354156355138, 6822.624755638289, 6889.689963951534, 6937.89593156093, 6941.861162776817, 6492.0, 6501.804945851632, 6556.3443655634055, 6568.770093046721, 6583.604983700993, 6679.833004174934, 6699.497537684596, 6822.283660215804, 6823.727050918106, 6880.862382752417, 6881.41507971828, 6899.689513971984, 6969.58182509051, 6980.092587963532, 6987.196472405535, 6615.834604134935, 6647.6676166192465, 6664.0670306158145, 6682.732690692318, 6765.729370825309, 6531.575447595891, 6621.503387246072, 6640.601563906181, 6653.1018312527185, 6710.496712746662, 6508.219013718384, 6598.439132673777, 6611.900821487778, 6673.165854268216, 6680.632565208765, 6714.563553369016, 6731.596104233761, 6742.595444273359, 6751.594904305757, 6780.762673306411, 6505.447037001908, 6507.739690412331, 6591.406773390418, 6597.934020659924, 6600.306967768507], "value": 6220.016037125054, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [863.3740538109871, 881.8060026794103, 883.4125306671064, 890.4123278636099, 891.6477991193478, 38519.0, 42267.78866105669, 42676.14647707044, 42702.0, 43093.35359969603, 39100.21799564007, 39352.803235983854, 39467.80266098666, 39487.21025579487, 39657.80171099141, 7174.139103307584, 7237.601931893743, 7306.926930730704, 7752.534847909115, 7944.483608565453, 7801.960990195041, 7908.090569584485, 7916.366690664762, 7959.2836644701965, 7985.880211796828, 7979.202079792032, 7994.720184793533, 8004.799880002988, 8028.598570071502, 8035.316998055172, 7976.122626511079, 8001.0, 8005.839883202361, 8006.67973281068, 8009.479383840032, 7897.2497612727275, 7929.881051784228, 7949.364050875916, 7962.402819788539, 7963.2833045025645, 39184.41223381623, 39276.41085383722, 39283.60716392828, 39313.21373572513, 39618.60381396178, 3491.4413693809124, 3517.6834084932225, 3528.541289632357, 3529.347070791886, 3552.147484603702, 32381.352372952646, 32517.83741081303, 32694.67305326964, 32698.836505817555, 32843.6715632843, 5188.558972487343, 5190.8183213587345, 5260.421353651095, 5292.100342941709, 5298.0, 190632.0, 190948.0, 192273.0, 192286.0, 192497.0, 43118.568814312086, 43688.563114369084, 49966.50033499691, 50063.24905126426, 50182.49817501851, 52142.0, 52806.20790688143, 53081.0, 53138.734306328995, 53148.20277695838, 14798.186099764402, 14798.630034249014, 14893.70212595742, 14950.028248163835, 14950.177740224175, 11785.528578856749, 11857.229280096766, 11872.762544749057, 11878.643640690792, 11953.880461195276, 14174.0, 14232.715345693236, 14232.928835355757, 14350.49773257931, 14587.927060364631, 5514.476124768141, 5576.9163462548095, 5670.943290567042, 5681.34664513578, 5744.339400968858, 1012.2155329619457, 1033.3902997231519, 1033.493588141805, 1037.1339931157418, 1049.7952899184586, 23205.767942320697, 23390.532189356116, 23410.7658923412, 23623.763762362156, 23949.640755388682, 1088.9945550272357, 1100.2683215661655, 1126.7859106769688, 1134.6142311614092, 1139.4701463819363, 12156.270623762603, 12366.886980171828, 12423.503059877503, 12437.067219958359, 12603.495860165674, 220416.0, 221410.0, 222023.0, 222292.0, 222372.0, 55153.0, 55375.723121384945, 55389.44610553923, 55572.72213638987, 55731.442685573435, 1417.0718179592384, 1461.663817322022, 1471.6909449015614, 1475.3508456279203, 1482.3306584259453, 22147.88926055424, 22821.31536053921, 22909.0, 23023.309300721005, 23333.76666233316, 38255.617443825206, 38513.0, 38519.614803851604, 38577.22845543017, 38664.42003370008, 190875.0, 192115.0, 194384.0, 195186.0, 196694.0, 31487.21281967969, 31933.36133277275, 34399.0, 34771.13072173216, 35741.285174296885, 43645.345319820866, 44137.33793993157, 44139.337909932015, 44565.0, 44585.331220031076, 32460.35079298448, 32507.18732031718, 32537.186570335933, 32836.83581582077, 32949.50575741414, 31445.0, 31465.528017079305, 31860.681393185772, 32003.519947200344, 32133.35733285368, 35148.0, 35386.64613353936, 35443.291134177685, 35649.1087722809, 35710.285794284486, 31602.82358571424, 31628.0, 31909.521357179197, 32064.0, 32414.83792581022, 23452.64821027652, 23490.765092349542, 23705.762942371046, 23871.04515819348, 24233.878830605736], "value": 17208.10077489054, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.725105574852, 581.4766709961032, 584.6141546579258, 594.0969726016455, 595.9463648271656, 22160.445988850268, 22638.20766273181, 22877.542449151028, 22882.427939301524, 23041.4239644009, 23361.0, 24979.62530562043, 25459.61810572843, 26045.08842190524, 26230.344241393974, 6601.999999999988, 6758.695858686347, 6761.053452516651, 6764.391204791567, 6768.627725475097, 6620.304867988864, 6700.798976030727, 6708.765193218238, 6709.36261055199, 6935.861282774342, 7195.928040719605, 7196.604186769726, 7197.064381630381, 7214.7114115435315, 7253.7098516059295, 7216.603086830222, 7225.530340527849, 7237.059182306319, 7237.710491580357, 7246.456515761339, 6644.269130395653, 6954.40887524561, 6960.617166055865, 6973.267806880306, 6979.965100174518, 30845.228869278224, 31407.0, 31454.89907853214, 31461.528077078634, 31468.055958321285, 2048.5083579940856, 2065.6694928811316, 2068.255428045902, 2068.834493240537, 2071.295759441782, 20439.284625038053, 20604.690929636068, 21105.0, 21300.573988520144, 21497.46256343588, 2528.1657053172407, 2545.350935511451, 2599.038355808344, 2606.5829467285143, 2612.7648511634043, 119784.0, 126494.0, 128440.35779821135, 138232.30883845515, 138861.3056934719, 20409.795902041085, 21025.579488410145, 22340.88829555842, 22508.324750257518, 22788.31635050951, 41812.372814407805, 41887.0, 41967.790161049, 41980.79009604932, 42161.789191053846, 10876.510557024953, 10930.398828064373, 10935.28920620157, 11049.944750276198, 11096.1123110151, 8947.776305592412, 8975.23710484603, 9004.909950900406, 9104.726858194264, 9119.04250053748, 11665.0, 11670.94164529172, 11765.529378824922, 11850.644480665595, 11856.822147667792, 3749.775013499199, 3825.035597412028, 4141.668666506733, 4273.777635629517, 4370.2570563004365, 937.95310234488, 942.7124726958343, 973.6738192705523, 973.6786860336072, 989.8267803134422, 19470.902645486683, 19495.22019119248, 19524.70712939307, 19596.412107636792, 20201.292954746514, 983.8179936711731, 1015.7663737340305, 1034.3173505486343, 1044.2011860926398, 1044.4046544337316, 10635.936406359302, 10836.458177091114, 10945.124390048777, 10969.177311701655, 11125.777484450266, 480136.0, 483800.0, 489488.0, 498344.0, 500102.0, 102972.48513757384, 106157.0, 108894.45552772186, 109074.0, 110418.0, 1046.9371837689764, 1091.9071878890384, 1144.8168293073068, 1158.530795028015, 1191.92252503587, 20788.792112078685, 20789.272375466786, 21097.050632721257, 21150.576988460452, 21180.68228976536, 54770.452295476534, 55592.44407555873, 56263.0, 57021.42978570161, 57750.4224957745, 67778.3222167772, 68241.0, 68453.0, 68776.0, 69015.0, 20004.299849505198, 20365.898170509052, 20547.58904821925, 20591.0, 20651.58696826025, 23251.651225231974, 23601.29196124119, 23680.763192367856, 23838.0, 23977.760222397552, 18843.340483083026, 18886.622267554845, 19022.1440035196, 19030.524236893634, 19041.333553325567, 16565.171741413124, 16679.332826686797, 16688.499345019667, 17109.572260693083, 17222.65554688874, 17668.29326826964, 18761.812381876553, 18953.0, 19168.329108481135, 19269.518262043563, 19852.90073549623, 20181.59636807285, 20222.090005949474, 20257.0, 20294.086766095857, 18726.15732292023, 18772.249110035445, 18777.718334224723, 19051.714224286923, 19225.615487689887], "value": 12989.899938418534, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1310.0894878059748, 1357.9524716634915, 1362.1282379277263, 1362.4550179928028, 1371.7462269480154, 15169.848301516995, 15824.68350632988, 15833.44582939596, 15866.52400427989, 15881.841181588181, 15531.68936621267, 15644.843551564481, 15707.136107514083, 15712.528624141265, 15714.607134821606, 2819.1824370932404, 2833.9372735224238, 2866.9139925802156, 2871.770258379325, 2879.9136025919256, 2808.0593001344573, 2811.0, 2835.2911772056987, 2835.9149225523265, 2839.034728192414, 2829.462402143586, 2832.900848470304, 2846.658400991884, 2848.1028476030087, 2849.116773800118, 2768.6400767900145, 2772.8336299822076, 2784.0951690700504, 2786.1362977476947, 2801.971980280212, 2673.8529380884042, 2678.6785585729835, 2697.109953715269, 2697.5009623219767, 2698.730126987305, 15033.699326013528, 15095.622609434742, 15116.924415377962, 15145.394184232617, 15295.923520382437, 8152.755417337489, 8474.067852536216, 8491.490510569323, 8499.957500212522, 8516.616752246164, 5329.147336426192, 5480.232767412565, 5623.606347555673, 5828.708564571797, 5833.2416785817995, 1919.9040047997685, 1950.2978927586057, 1959.8334141597982, 1994.840412766975, 2007.9498012549657, 24978.250652480456, 25584.87207563969, 25836.612450813253, 26292.60561091604, 27880.30299242515, 7278.672459739324, 7310.963445182846, 7399.556026638311, 7569.962150189324, 7610.972518710014, 20723.58552828935, 20830.895845520674, 20840.895795520926, 20863.269785557433, 20948.0, 8358.874616880752, 8394.874076888851, 8400.663973440995, 8409.075001749803, 8434.451760635538, 7269.63651817407, 7571.545707257582, 7593.924060759432, 7650.693972241159, 7680.270374314431, 5591.692456914828, 5808.5062769665055, 5824.388439213906, 5838.182654428383, 5876.382979787061, 1824.489143039951, 1828.7988321284647, 1862.3658907637541, 1883.7645294338208, 1893.5360836594848, 885.8671199320024, 902.6163880350824, 907.6414816147717, 910.8041771019263, 917.0554329040965, 8488.278496327757, 8761.0, 8856.202941735146, 8865.64537418509, 8905.154010369004, 672.7342699633617, 685.6845850908538, 696.8153439338579, 699.909011828459, 706.5760543673755, 4777.689450185727, 4796.304535842283, 4801.903961920742, 4818.566329030404, 4826.734529600905, 20804.583908321747, 22609.434764131027, 22624.434389140402, 22645.320640380814, 22647.094116235494, 21324.466888327916, 21584.892075539523, 22068.448288792588, 22129.889350553465, 22156.449048566446, 9760.267979901393, 10098.848517272247, 11309.09527237819, 11523.539058437736, 11801.763964720658, 8877.689280875138, 8899.466032038099, 8958.91041089607, 9065.637374504946, 9096.636134554808, 17580.560485987953, 18880.150393232612, 19286.132124054733, 19692.803071969098, 19864.70202946928, 19410.4176874694, 19652.50868728293, 19905.10427030758, 20018.299359522345, 20090.799092008892, 11199.496022679163, 11490.82763758561, 11492.712682183012, 11605.245659032473, 11605.941970290094, 13820.101693389897, 13821.447142114203, 13997.790033149715, 13998.580042598738, 14010.719785604435, 11557.653270401901, 11685.76628467443, 11737.88262117368, 11752.70618234551, 12022.63932082039, 11245.831312530156, 11315.773684526428, 11439.942800285946, 11483.885161148282, 11489.82765258505, 9491.061893022055, 9683.273754468584, 9937.850932236166, 9940.552675129782, 9999.850002249827, 6969.233384327618, 7122.278090406454, 7163.749268775777, 7184.0, 7247.746328878675, 7207.495475316678, 7266.636668166676, 7300.525465844703, 7400.000999864949, 7494.5503269803985], "value": 6841.867543156819, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [509.68144909431606, 531.0006290772378, 537.7606964900621, 539.7759929629199, 540.2247774443675, 6284.528660350475, 6403.807885763429, 6482.120185146302, 6483.254425741041, 6502.31725668805, 6158.353372895848, 6239.3465731581055, 6257.937420625793, 6282.277538083111, 6309.873802523946, 5204.0, 5220.2430647556275, 5225.399079105913, 5239.633225674204, 5263.578913686896, 4869.537393947569, 5093.770780314876, 5188.844334669966, 5199.298094757197, 5221.198686453167, 4994.225894986283, 5025.623078269126, 5054.349998001847, 5065.392152941652, 5083.085044691972, 4987.055048531076, 5013.122703526905, 5023.547880690755, 5042.722650254272, 5060.51925067118, 4431.161068156711, 4478.820847166109, 4528.728276303399, 4539.909201815945, 4567.954320456786, 6204.441600255998, 6251.937480625181, 6293.779717709858, 6309.305976342599, 6323.52573556985, 5808.59339846211, 5820.476157145878, 5831.9416805831825, 5858.53131749459, 5881.735321910524, 6559.278479367265, 6574.737010519573, 6601.339866013408, 6625.238097618787, 6653.634050127241, 4881.975590122062, 4914.1817527514695, 4946.703197808107, 4949.515145456385, 4973.0, 6635.270120286765, 6854.725810967555, 6861.313868613099, 6889.6919531956855, 6928.515003949726, 5023.14606516893, 5033.169527028, 5058.962912602908, 5094.159463688524, 5099.209622508517, 5097.745112744348, 5171.379434467888, 5191.351081114861, 5191.5846732261325, 5196.506331898464, 5769.480746732815, 5770.855728606734, 5776.913346299809, 5817.970910145422, 5843.152742852262, 6694.230163531159, 6740.191177058687, 6755.1556055493065, 6761.966190169018, 6772.0, 1776.8845025073588, 1785.7053586158138, 1794.1477798046085, 1811.5652243461475, 1814.9364772233173, 1163.96508104757, 1232.580922486359, 1246.3830403950103, 1248.9375531223402, 1255.5731051442554, 5734.311882574118, 5734.713264336767, 5754.7339585291165, 5754.88490230193, 5777.537796976232, 6795.490338224653, 6809.0, 6824.761133360308, 6826.283240259701, 6841.939499377604, 5643.194177863044, 5675.489205971482, 5699.401562835926, 5713.428657134254, 5723.7996670116345, 3561.4479755637917, 3568.6074531801482, 3572.1783989682, 3587.210813620999, 3603.585587657453, 6123.785667501616, 6280.780172693934, 6418.807435776934, 6491.415772580491, 6544.443722283564, 6669.599824010478, 6759.188897332253, 6765.797026089225, 6840.897386539206, 6844.726210951506, 6335.208098987627, 6336.6831658416895, 6453.741850325934, 6456.578013652772, 6497.4477169441125, 6614.702338394687, 6630.237522684953, 6660.467162627075, 6728.865422691617, 6797.422219111431, 6596.769113081019, 6633.7678181265355, 6687.76592819249, 6754.797356079325, 6773.62745049027, 6453.096566480603, 6492.675366231764, 6522.15212022434, 6525.804225873231, 6566.671666416564, 4929.507049295042, 4981.128302547112, 5013.623978201576, 5013.623978201576, 5031.371078615173, 6522.673866306761, 6637.535372523877, 6681.799546013627, 6724.0, 6796.5143005616055, 6437.517186210959, 6446.226452825691, 6463.612183269019, 6479.384458476437, 6563.540552161303, 6422.229332480132, 6463.289038205888, 6491.285958544462, 6542.934570654423, 6612.437942774918, 6362.331955144643, 6408.743650253938, 6459.418652321314, 6466.450351719968, 6503.382178693017, 6390.3221133916095, 6504.60972341661, 6620.867582648417, 6633.635150066792, 6639.767608133692, 6240.469560087444, 6279.403456671609, 6369.840753981188, 6389.744410223539, 6473.769983703081], "value": 5098.182475257555, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [886.5655828643964, 900.657750054979, 933.3699752666948, 936.8735220745201, 938.1931538876565, 19391.806081939176, 20208.292709755162, 20275.08762105705, 20353.38939831804, 20399.99999999998, 16802.579935501588, 16854.157292135376, 17557.91221043893, 18414.263429462804, 18661.34685286015, 968.0996673094037, 982.9262805289596, 987.6543209876558, 989.1246247071358, 989.8762654668167, 982.9508524573779, 986.2800155886207, 986.8273052215869, 987.2644879564734, 998.0119681515284, 1009.8535712321709, 1043.8956104389576, 1056.10758908722, 1056.7146870345002, 1058.1534772182224, 1028.3367228137884, 1042.6663467690341, 1043.056034288962, 1043.056034288966, 1044.613493007592, 727.3853593713304, 749.636426333228, 749.6401727170934, 750.4934169435609, 753.2994315286782, 20606.27878024277, 20694.275700350565, 20747.896260518603, 20827.062782174686, 20865.269715560033, 20678.0, 21029.47426314339, 21795.455113622127, 21841.126354945784, 21852.562948740935, 17338.479845604525, 17515.12424378776, 17563.73654395185, 17677.7348339775, 17686.0, 3764.0, 3774.8678796242275, 3784.413415920537, 3787.072167318997, 3790.6019867913747, 136679.0, 137968.0, 138356.0, 138789.99999999898, 141911.0, 16829.663406731797, 16943.661126777395, 17201.225944832513, 17210.31158753636, 17237.655246895243, 31641.52537711936, 32018.679813202034, 32038.519422208687, 32503.837480812446, 32670.83664581662, 8894.110588941054, 9033.277337812959, 9049.547522623843, 9053.909460905306, 9061.909380906107, 4283.186194623012, 4425.070735145656, 4491.416115904912, 4514.345419914094, 4529.750863702528, 5459.754311056012, 5588.832335029955, 5603.047481928082, 5614.831555053355, 5621.241132447068, 1026.8049070676548, 1059.2426415113232, 1067.178272730009, 1075.7203127186988, 1076.8707755069443, 676.0670275020441, 683.9316068393221, 701.4598758955576, 704.6124631452783, 706.5619316023996, 11592.826107608393, 11766.352850593299, 11977.880221197676, 12131.0, 12274.079444041732, 670.5741853922794, 680.8536164724608, 693.9722411103601, 699.3426179391356, 707.6320313436984, 5196.324477817935, 5223.4515375884985, 5261.158214685632, 5296.3379577552805, 5345.412004679482, 112706.0, 114251.0, 115213.42393288147, 116469.41765291289, 117890.41054794671, 98254.5087274559, 100118.0, 100880.49559752301, 102188.0, 103004.48497757463, 85150.0, 87903.0, 90469.0, 90474.99999999869, 90611.09388906027, 9706.708798735766, 9810.803783924424, 9934.403935763878, 10203.28576999603, 10205.38767673942, 42435.363469548596, 44004.55995440004, 44490.11019779651, 44750.3287450695, 44762.3285650722, 56552.73789048392, 57126.428735712114, 57390.426095738505, 57787.0, 58845.411545885705, 14476.348564314421, 15290.0, 15499.225038748244, 15610.297536611108, 15731.528054158394, 18258.72611910849, 18309.3591724289, 18373.54066148357, 18391.540211494284, 18554.721679174552, 15367.077975321516, 15396.538103856903, 15610.609734756721, 15669.0, 15838.52484425469, 14453.566393008226, 14659.340329684976, 14794.334254958338, 14871.330790114254, 14891.329890154753, 14075.648108797363, 14138.78791818103, 14328.713425731636, 14359.210243436712, 14525.564233073024, 12545.87454125447, 12758.936205318914, 12811.743765124458, 12835.807462888251, 12921.870781292442, 11373.488193031168, 11467.483963221508, 11552.0, 11599.304041757521, 11602.129840261845], "value": 8896.995401732176, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1432.2999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 107.0, 105.0, 107.0, 107.0, 107.0, 108.0, 107.0, 107.0, 106.0], "value": 106.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 120.0, 144.0, 118.0, 121.0, 145.0, 117.0, 142.0], "value": 125.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 164.0, 162.0, 162.0, 163.0, 165.0, 167.0, 167.0, 166.0], "value": 164.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 74.0, 73.0, 73.0, 76.0, 75.0, 74.0, 79.0, 74.0], "value": 74.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 79.0, 78.0, 78.0, 80.0, 79.0, 79.0, 78.0, 79.0], "value": 79.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 113.0, 113.0, 117.0, 114.0, 115.0, 114.0, 115.0, 114.0, 114.0], "value": 114.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 147.0, 149.0, 149.0, 149.0, 149.0, 147.0, 149.0, 148.0], "value": 148.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 93.0, 95.0, 94.0, 94.0, 93.0, 95.0], "value": 94.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 54.0, 53.0, 56.0, 53.0, 52.0, 56.0, 53.0, 52.0], "value": 53.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [42.0, 43.0, 42.0, 38.0, 39.0, 39.0, 39.0, 39.0, 38.0, 41.0], "value": 40.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 74.0, 77.0, 73.0, 76.0, 82.0, 74.0, 77.0, 77.0], "value": 75.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 119.0, 111.0, 114.0, 116.0, 116.0, 115.0, 108.0, 116.0, 115.0], "value": 114.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 172.0, 181.0, 173.0, 168.0, 175.0, 173.0, 173.0, 170.0, 171.0], "value": 173.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 66.0, 67.0, 65.0, 67.0, 68.0, 66.0, 68.0, 65.0, 70.0], "value": 67.1, "unit": "score"}]}]} 09:40:06 INFO - Return code: 0 09:40:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:40:06 INFO - # TBPL SUCCESS # 09:40:06 INFO - Running post-action listener: _package_coverage_data 09:40:06 INFO - Running post-action listener: _resource_record_post_action 09:40:06 INFO - [mozharness: 2017-09-21 16:40:06.686758Z] Finished run-tests step (success) 09:40:06 INFO - Running post-run listener: _resource_record_post_run 09:40:06 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 9875456; Write bytes: 490770432; Read time: 3736; Write time: 621636 09:40:06 INFO - TinderboxPrint: CPU usage
13.1% 09:40:06 INFO - TinderboxPrint: I/O read bytes / time
9,875,456 / 3,736 09:40:06 INFO - TinderboxPrint: I/O write bytes / time
490,770,432 / 621,636 09:40:06 INFO - TinderboxPrint: CPU idle
8,253.2 (86.8%) 09:40:06 INFO - TinderboxPrint: CPU user
1,191.2 (12.5%) 09:40:06 INFO - TinderboxPrint: Swap in / out
0 / 0 09:40:06 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 57823232; Read time: 112; Write time: 33540 09:40:06 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 09:40:06 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 7507968; Write bytes: 432947200; Read time: 3420; Write time: 588096 09:40:07 INFO - Running post-run listener: _upload_blobber_files 09:40:07 INFO - Blob upload gear active. 09:40:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:40:07 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 09:40:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:40:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:40:07 INFO - (blobuploader) - INFO - Open directory for files ... 09:40:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 09:40:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:40:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:40:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 09:40:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:40:08 INFO - (blobuploader) - INFO - Done attempting. 09:40:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:40:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:40:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:40:09 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:40:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:40:09 INFO - (blobuploader) - INFO - Done attempting. 09:40:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:40:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:40:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:40:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:40:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:40:12 INFO - (blobuploader) - INFO - Done attempting. 09:40:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 09:40:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:40:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:40:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 09:40:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:40:13 INFO - (blobuploader) - INFO - Done attempting. 09:40:13 INFO - (blobuploader) - INFO - Iteration through files over. 09:40:13 INFO - Return code: 0 09:40:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:40:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:40:13 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d4b185b7963f09ff3b717bb3dc2fd3b72c8f8dbae30038d0877a6d4f6093baf75b7f02c102e5ced2a1b52ec70be65c7d1b5cfead544e8e79e52f8c108394809a", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/38ac6c53d9fc3f52f7926db5771044f76b3d3df3bf9c2ffb2ece8a787e47f761ce9b54b6ed5448db090578aa731b1082b31817ba50fdd822892d14c32f81409e", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/38b4f194a79de67f84f42db8eda3e217c2eb973d4bcc3d91b659861385647c6a7c49fbc7534734b82f02e96011f01b643b95516cb6af9c92b0cd4029b23f9d0f", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/df076d8092dfe7ed7aa39af0605491abedfa2e7b47cad5acb22242b8566dcc25003074b54dbd4c6558cd4b21814f8dc0ea297afd5fa23be5a381ca3bdf40cb29"} 09:40:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:40:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:40:13 INFO - Contents: 09:40:13 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d4b185b7963f09ff3b717bb3dc2fd3b72c8f8dbae30038d0877a6d4f6093baf75b7f02c102e5ced2a1b52ec70be65c7d1b5cfead544e8e79e52f8c108394809a", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/38ac6c53d9fc3f52f7926db5771044f76b3d3df3bf9c2ffb2ece8a787e47f761ce9b54b6ed5448db090578aa731b1082b31817ba50fdd822892d14c32f81409e", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/38b4f194a79de67f84f42db8eda3e217c2eb973d4bcc3d91b659861385647c6a7c49fbc7534734b82f02e96011f01b643b95516cb6af9c92b0cd4029b23f9d0f", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/df076d8092dfe7ed7aa39af0605491abedfa2e7b47cad5acb22242b8566dcc25003074b54dbd4c6558cd4b21814f8dc0ea297afd5fa23be5a381ca3bdf40cb29"} 09:40:13 INFO - Running post-run listener: copy_logs_to_upload_dir 09:40:13 INFO - Copying logs to upload dir... 09:40:13 INFO - mkdir: /builds/slave/test/build/upload/logs 09:40:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.199725 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2017-09-21 09:40:13.979467) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-21 09:40:13.985999) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1506010768.330791-388580899 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d4b185b7963f09ff3b717bb3dc2fd3b72c8f8dbae30038d0877a6d4f6093baf75b7f02c102e5ced2a1b52ec70be65c7d1b5cfead544e8e79e52f8c108394809a", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/38ac6c53d9fc3f52f7926db5771044f76b3d3df3bf9c2ffb2ece8a787e47f761ce9b54b6ed5448db090578aa731b1082b31817ba50fdd822892d14c32f81409e", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/38b4f194a79de67f84f42db8eda3e217c2eb973d4bcc3d91b659861385647c6a7c49fbc7534734b82f02e96011f01b643b95516cb6af9c92b0cd4029b23f9d0f", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/df076d8092dfe7ed7aa39af0605491abedfa2e7b47cad5acb22242b8566dcc25003074b54dbd4c6558cd4b21814f8dc0ea297afd5fa23be5a381ca3bdf40cb29"} build_url:https://queue.taskcluster.net/v1/task/HBJ4E0WUSRGZbfHgz26VAA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011255 build_url: 'https://queue.taskcluster.net/v1/task/HBJ4E0WUSRGZbfHgz26VAA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d4b185b7963f09ff3b717bb3dc2fd3b72c8f8dbae30038d0877a6d4f6093baf75b7f02c102e5ced2a1b52ec70be65c7d1b5cfead544e8e79e52f8c108394809a", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/38ac6c53d9fc3f52f7926db5771044f76b3d3df3bf9c2ffb2ece8a787e47f761ce9b54b6ed5448db090578aa731b1082b31817ba50fdd822892d14c32f81409e", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/38b4f194a79de67f84f42db8eda3e217c2eb973d4bcc3d91b659861385647c6a7c49fbc7534734b82f02e96011f01b643b95516cb6af9c92b0cd4029b23f9d0f", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/df076d8092dfe7ed7aa39af0605491abedfa2e7b47cad5acb22242b8566dcc25003074b54dbd4c6558cd4b21814f8dc0ea297afd5fa23be5a381ca3bdf40cb29"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-21 09:40:14.022186) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 09:40:14.022637) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1506010768.330791-388580899 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004448 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 09:40:14.103437) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-21 09:40:14.103884) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-21 09:40:14.104439) ========= ========= Total master_lag: 0.21 =========