builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s-pgo slave: talos-linux64-ix-081 starttime: 1506454925.55 results: success (0) revision: 39aaf54972cb11a63815a96b532786133baa95bc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-26 12:42:05.553629) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-26 12:42:05.553995) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-26 12:42:05.554265) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-26 12:42:05.630173) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 12:42:05.630538) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=483e410453545d07cca6935c000001ab-1506454499.797509-1446205962 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-26 12:42:05-- 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% 46.6M=0s 2017-09-26 12:42:05 (46.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.118593 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 12:42:05.775675) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 12:42:05.776039) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=483e410453545d07cca6935c000001ab-1506454499.797509-1446205962 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020971 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 12:42:05.829444) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 12:42:05.830218) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 39aaf54972cb11a63815a96b532786133baa95bc --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 39aaf54972cb11a63815a96b532786133baa95bc --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=483e410453545d07cca6935c000001ab-1506454499.797509-1446205962 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-26 12:42:05,889 truncating revision to first 12 chars 2017-09-26 12:42:05,889 Setting DEBUG logging. 2017-09-26 12:42:05,889 attempt 1/10 2017-09-26 12:42:05,889 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/39aaf54972cb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-26 12:42:06,137 unpacking tar archive at: mozilla-central-39aaf54972cb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.574612 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 12:42:06.425145) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-26 12:42:06.425466) ========= script_repo_revision: 39aaf54972cb11a63815a96b532786133baa95bc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-26 12:42:06.425892) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-26 12:42:06.426194) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-26 12:42:06.440426) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2017-09-26 12:42:06.440941) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-stylo-disabled-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=483e410453545d07cca6935c000001ab-1506454499.797509-1446205962 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:42:06 INFO - MultiFileLogger online at 20170926 12:42:06 in /builds/slave/test 12:42:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 12:42:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:42:06 INFO - {'append_to_log': False, 12:42:06 INFO - 'base_work_dir': '/builds/slave/test', 12:42:06 INFO - 'blob_upload_branch': 'Firefox', 12:42:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:42:06 INFO - 'branch': 'Firefox', 12:42:06 INFO - 'buildbot_json_path': 'buildprops.json', 12:42:06 INFO - 'code_coverage': False, 12:42:06 INFO - 'config_files': ('talos/linux_config.py',), 12:42:06 INFO - 'default_actions': ('clobber', 12:42:06 INFO - 'read-buildbot-config', 12:42:06 INFO - 'download-and-extract', 12:42:06 INFO - 'populate-webroot', 12:42:06 INFO - 'create-virtualenv', 12:42:06 INFO - 'install', 12:42:06 INFO - 'setup-mitmproxy', 12:42:06 INFO - 'run-tests'), 12:42:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:42:06 INFO - 'disable_ccov_upload': False, 12:42:06 INFO - 'disable_stylo': False, 12:42:06 INFO - 'download_minidump_stackwalk': True, 12:42:06 INFO - 'download_symbols': 'ondemand', 12:42:06 INFO - 'enable_stylo': False, 12:42:06 INFO - 'enable_webrender': False, 12:42:06 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 12:42:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:42:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:42:06 INFO - 'gecko_profile': False, 12:42:06 INFO - 'gecko_profile_interval': 0, 12:42:06 INFO - 'installer_path': 'installer.exe', 12:42:06 INFO - 'log_level': 'info', 12:42:06 INFO - 'log_name': 'talos', 12:42:06 INFO - 'log_to_console': True, 12:42:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:42:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:42:06 INFO - 'opt_config_files': (), 12:42:06 INFO - 'pip_index': False, 12:42:06 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 12:42:06 INFO - 'system_bits': '32', 12:42:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:42:06 INFO - 'title': 'talos-linux64-ix-081', 12:42:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:42:06 INFO - 'use_talos_json': True, 12:42:06 INFO - 'verify': 'False', 12:42:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:42:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:42:06 INFO - 'work_dir': 'build'} 12:42:06 INFO - [mozharness: 2017-09-26 19:42:06.641459Z] Running clobber step. 12:42:06 INFO - Running pre-action listener: _resource_record_pre_action 12:42:06 INFO - Running main action method: clobber 12:42:06 INFO - rmtree: /builds/slave/test/build 12:42:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:42:08 INFO - Running post-action listener: _resource_record_post_action 12:42:08 INFO - [mozharness: 2017-09-26 19:42:08.146920Z] Finished clobber step (success) 12:42:08 INFO - [mozharness: 2017-09-26 19:42:08.147018Z] Running read-buildbot-config step. 12:42:08 INFO - Running pre-action listener: _resource_record_pre_action 12:42:08 INFO - Running main action method: read_buildbot_config 12:42:08 INFO - Using buildbot properties: 12:42:08 INFO - { 12:42:08 INFO - "project": "", 12:42:08 INFO - "product": "firefox", 12:42:08 INFO - "who": "ryanvm@gmail.com", 12:42:08 INFO - "installer_path": "public/build/target.tar.bz2", 12:42:08 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 12:42:08 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 12:42:08 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-stylo-disabled-e10s", 12:42:08 INFO - "stage_platform": "linux64-pgo", 12:42:08 INFO - "basedir": "/builds/slave/test", 12:42:08 INFO - "buildnumber": 43, 12:42:08 INFO - "platform": "ubuntu64_hw", 12:42:08 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 12:42:08 INFO - "slavebuilddir": "test", 12:42:08 INFO - "taskId": "cpceKIg7Qne29xD7XZ5oYw", 12:42:08 INFO - "branch": "mozilla-central", 12:42:08 INFO - "script_repo_revision": "production", 12:42:08 INFO - "revision": "39aaf54972cb11a63815a96b532786133baa95bc", 12:42:08 INFO - "slavename": "talos-linux64-ix-081", 12:42:08 INFO - "repo_path": "mozilla-central" 12:42:08 INFO - } 12:42:08 INFO - Finding installer, test and symbols from parent task. 12:42:08 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cpceKIg7Qne29xD7XZ5oYw'}, attempt #1 12:42:08 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cpceKIg7Qne29xD7XZ5oYw'}, attempt #1 12:42:09 INFO - Task dependencies: JSqdHGsuRK2AZcN3JGZ2xg 12:42:09 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JSqdHGsuRK2AZcN3JGZ2xg'}, attempt #1 12:42:09 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/JSqdHGsuRK2AZcN3JGZ2xg/artifacts/public/build/target.tar.bz2 12:42:09 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/JSqdHGsuRK2AZcN3JGZ2xg/artifacts/public/build/target.test_packages.json 12:42:09 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/JSqdHGsuRK2AZcN3JGZ2xg/artifacts/public/build/target.crashreporter-symbols.zip 12:42:09 INFO - Running post-action listener: _resource_record_post_action 12:42:09 INFO - [mozharness: 2017-09-26 19:42:09.485532Z] Finished read-buildbot-config step (success) 12:42:09 INFO - [mozharness: 2017-09-26 19:42:09.485747Z] Running download-and-extract step. 12:42:09 INFO - Running pre-action listener: _resource_record_pre_action 12:42:09 INFO - Running main action method: download_and_extract 12:42:09 INFO - mkdir: /builds/slave/test/build/tests 12:42:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:42:09 INFO - trying https://queue.taskcluster.net/v1/task/JSqdHGsuRK2AZcN3JGZ2xg/artifacts/public/build/target.test_packages.json 12:42:09 INFO - Downloading https://queue.taskcluster.net/v1/task/JSqdHGsuRK2AZcN3JGZ2xg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 12:42:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JSqdHGsuRK2AZcN3JGZ2xg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 12:42:10 INFO - Downloaded 989 bytes. 12:42:10 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 12:42:10 INFO - Using the following test package requirements: 12:42:10 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 12:42:10 INFO - u'common': [u'target.common.tests.zip'], 12:42:10 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 12:42:10 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 12:42:10 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 12:42:10 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 12:42:10 INFO - u'mozbase': [u'target.common.tests.zip'], 12:42:10 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 12:42:10 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 12:42:10 INFO - u'web-platform': [u'target.common.tests.zip', 12:42:10 INFO - u'target.web-platform.tests.tar.gz'], 12:42:10 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 12:42:10 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 12:42:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JSqdHGsuRK2AZcN3JGZ2xg/artifacts/public/build/target.common.tests.zip 12:42:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JSqdHGsuRK2AZcN3JGZ2xg/artifacts/public/build/target.common.tests.zip'}, attempt #1 12:42:10 INFO - Fetch https://queue.taskcluster.net/v1/task/JSqdHGsuRK2AZcN3JGZ2xg/artifacts/public/build/target.common.tests.zip into memory 12:42:11 INFO - Content-Length response header: 55347503 12:42:11 INFO - Bytes received: 55347503 12:42:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JSqdHGsuRK2AZcN3JGZ2xg/artifacts/public/build/target.talos.tests.zip 12:42:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JSqdHGsuRK2AZcN3JGZ2xg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 12:42:22 INFO - Fetch https://queue.taskcluster.net/v1/task/JSqdHGsuRK2AZcN3JGZ2xg/artifacts/public/build/target.talos.tests.zip into memory 12:42:23 INFO - Content-Length response header: 14513823 12:42:23 INFO - Bytes received: 14513823 12:42:23 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')]} 12:42:23 INFO - trying https://queue.taskcluster.net/v1/task/JSqdHGsuRK2AZcN3JGZ2xg/artifacts/public/build/target.tar.bz2 12:42:23 INFO - Downloading https://queue.taskcluster.net/v1/task/JSqdHGsuRK2AZcN3JGZ2xg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 12:42:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JSqdHGsuRK2AZcN3JGZ2xg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 12:42:24 INFO - Downloaded 62313077 bytes. 12:42:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JSqdHGsuRK2AZcN3JGZ2xg/artifacts/public/build/target.tar.bz2 12:42:25 INFO - mkdir: /builds/slave/test/properties 12:42:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:42:25 INFO - Writing to file /builds/slave/test/properties/build_url 12:42:25 INFO - Contents: 12:42:25 INFO - build_url:https://queue.taskcluster.net/v1/task/JSqdHGsuRK2AZcN3JGZ2xg/artifacts/public/build/target.tar.bz2 12:42:25 INFO - Running post-action listener: _resource_record_post_action 12:42:25 INFO - Running post-action listener: find_tests_for_verification 12:42:25 INFO - Running post-action listener: set_extra_try_arguments 12:42:25 INFO - [mozharness: 2017-09-26 19:42:25.065541Z] Finished download-and-extract step (success) 12:42:25 INFO - [mozharness: 2017-09-26 19:42:25.065642Z] Running populate-webroot step. 12:42:25 INFO - Running pre-action listener: _resource_record_pre_action 12:42:25 INFO - Running main action method: populate_webroot 12:42:25 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:42:25 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:42:25 INFO - 'tests': ['tresize', 12:42:25 INFO - 'tcanvasmark']}, 12:42:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:42:25 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:42:25 INFO - 'tests': ['dromaeo_css', 12:42:25 INFO - 'kraken']}, 12:42:25 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 12:42:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:42:25 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 12:42:25 INFO - 'talos_options': ['--disable-stylo'], 12:42:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:42:25 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 12:42:25 INFO - 'tests': ['damp', 'tps']}, 12:42:25 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 12:42:25 INFO - 'talos_options': ['--disable-stylo'], 12:42:25 INFO - 'tests': ['damp', 'tps']}, 12:42:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:42:25 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:42:25 INFO - 'tests': ['dromaeo_dom']}, 12:42:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 12:42:25 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:42:25 INFO - 'tests': ['basic_compositor_video', 12:42:25 INFO - 'glvideo']}, 12:42:25 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 12:42:25 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 12:42:25 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 12:42:25 INFO - 'talos_options': ['--disable-stylo'], 12:42:25 INFO - 'tests': ['ts_paint_webext', 12:42:25 INFO - 'tp5o_webext']}, 12:42:25 INFO - 'other-e10s': {'tests': ['a11yr', 12:42:25 INFO - 'ts_paint', 12:42:25 INFO - 'tpaint', 12:42:25 INFO - 'sessionrestore', 12:42:25 INFO - 'sessionrestore_many_windows', 12:42:25 INFO - 'sessionrestore_no_auto_restore', 12:42:25 INFO - 'tabpaint']}, 12:42:25 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:42:25 INFO - 'tests': ['a11yr', 12:42:25 INFO - 'ts_paint', 12:42:25 INFO - 'tpaint', 12:42:25 INFO - 'sessionrestore', 12:42:25 INFO - 'sessionrestore_many_windows', 12:42:25 INFO - 'sessionrestore_no_auto_restore', 12:42:25 INFO - 'tabpaint']}, 12:42:25 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 12:42:25 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 12:42:25 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:42:25 INFO - 'tests': ['perf_reftest_singletons']}, 12:42:25 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:42:25 INFO - 'tests': ['perf_reftest']}, 12:42:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:42:25 INFO - 'tsvgr_opacity', 12:42:25 INFO - 'tart', 12:42:25 INFO - 'tscrollx', 12:42:25 INFO - 'tsvg_static']}, 12:42:25 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:42:25 INFO - 'tests': ['tsvgx', 12:42:25 INFO - 'tsvgr_opacity', 12:42:25 INFO - 'tart', 12:42:25 INFO - 'tscrollx', 12:42:25 INFO - 'tsvg_static']}, 12:42:25 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 12:42:25 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 12:42:25 INFO - 'talos_options': ['--disable-stylo'], 12:42:25 INFO - 'tests': ['tp5o']}, 12:42:25 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 12:42:25 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 12:42:25 INFO - 'talos_options': ['--mitmproxy', 12:42:25 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 12:42:25 INFO - '--firstNonBlankPaint'], 12:42:25 INFO - 'tests': ['tp6_google', 12:42:25 INFO - 'tp6_youtube', 12:42:25 INFO - 'tp6_amazon', 12:42:25 INFO - 'tp6_facebook']}, 12:42:25 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 12:42:25 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 12:42:25 INFO - 'talos_options': ['--disable-stylo', 12:42:25 INFO - '--mitmproxy', 12:42:25 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 12:42:25 INFO - '--firstNonBlankPaint'], 12:42:25 INFO - 'tests': ['tp6_google', 12:42:25 INFO - 'tp6_youtube', 12:42:25 INFO - 'tp6_amazon', 12:42:25 INFO - 'tp6_facebook']}, 12:42:25 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 12:42:25 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 12:42:25 INFO - 'talos_options': ['--stylo-threads=1', 12:42:25 INFO - '--mitmproxy', 12:42:25 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 12:42:25 INFO - '--firstNonBlankPaint'], 12:42:25 INFO - 'tests': ['tp6_google', 12:42:25 INFO - 'tp6_youtube', 12:42:25 INFO - 'tp6_amazon', 12:42:25 INFO - 'tp6_facebook']}, 12:42:25 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 12:42:25 INFO - 'talos_options': ['--xperf_path', 12:42:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:42:25 INFO - 'tests': ['tp5n']}, 12:42:25 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 12:42:25 INFO - 'talos_options': ['--disable-stylo', 12:42:25 INFO - '--xperf_path', 12:42:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:42:25 INFO - 'tests': ['tp5n']}}} 12:42:25 INFO - Running post-action listener: _resource_record_post_action 12:42:25 INFO - [mozharness: 2017-09-26 19:42:25.086428Z] Finished populate-webroot step (success) 12:42:25 INFO - [mozharness: 2017-09-26 19:42:25.086517Z] Running create-virtualenv step. 12:42:25 INFO - Running pre-action listener: _resource_record_pre_action 12:42:25 INFO - Running main action method: create_virtualenv 12:42:25 INFO - Creating virtualenv /builds/slave/test/build/venv 12:42:25 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 12:42:25 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 12:42:25 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 12:42:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:42:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:42:25 INFO - Installing distribute.............................................................................................................................................................................................done. 12:42:25 INFO - Installing pip...............done. 12:42:25 INFO - Return code: 0 12:42:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:42:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:42:26 INFO - Reading from file tmpfile_stdout 12:42:26 INFO - Output received: 12:42:26 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 12:42:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:42:26 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')]} 12:42:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:42:26 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')]} 12:42:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:42:26 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 0xd1f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108c9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089d60>, '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 0x108aa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108aef0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1506454499.797509-1446205962', '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 12:42:26 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 12:42:26 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 12:42:26 INFO - Using env: {'DISPLAY': ':0', 12:42:26 INFO - 'HOME': '/home/cltbld', 12:42:26 INFO - 'LANG': 'en_US.UTF-8', 12:42:26 INFO - 'LANGUAGE': 'en_US:en', 12:42:26 INFO - 'LOGNAME': 'cltbld', 12:42:26 INFO - 'MAIL': '/var/mail/cltbld', 12:42:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:42:26 INFO - 'MOZ_NO_REMOTE': '1', 12:42:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:42:26 INFO - 'NO_EM_RESTART': '1', 12:42:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:42:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:42:26 INFO - 'PWD': '/builds/slave/test', 12:42:26 INFO - 'SHELL': '/bin/bash', 12:42:26 INFO - 'SHLVL': '1', 12:42:26 INFO - 'TERM': 'linux', 12:42:26 INFO - 'TMOUT': '86400', 12:42:26 INFO - 'USER': 'cltbld', 12:42:26 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1506454499.797509-1446205962', 12:42:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:42:26 INFO - '_': '/tools/buildbot/bin/python'} 12:42:27 INFO - Ignoring indexes: http://pypi.python.org/simple/ 12:42:27 INFO - Downloading/unpacking pip>=1.5 12:42:27 INFO - Running setup.py egg_info for package pip 12:42:27 INFO - warning: no files found matching 'pip/cacert.pem' 12:42:27 INFO - warning: no files found matching '*.html' under directory 'docs' 12:42:27 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 12:42:27 INFO - no previously-included directories found matching 'docs/_build/_sources' 12:42:27 INFO - Installing collected packages: pip 12:42:27 INFO - Found existing installation: pip 1.1 12:42:27 INFO - Uninstalling pip: 12:42:27 INFO - Successfully uninstalled pip 12:42:27 INFO - Running setup.py install for pip 12:42:27 INFO - warning: no files found matching 'pip/cacert.pem' 12:42:27 INFO - warning: no files found matching '*.html' under directory 'docs' 12:42:27 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 12:42:27 INFO - no previously-included directories found matching 'docs/_build/_sources' 12:42:27 INFO - Installing pip script to /builds/slave/test/build/venv/bin 12:42:27 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 12:42:27 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 12:42:27 INFO - Successfully installed pip 12:42:27 INFO - Cleaning up... 12:42:27 INFO - Return code: 0 12:42:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:42:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:42:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:42:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:42:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:42:27 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 0xd1f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108c9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089d60>, '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 0x108aa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108aef0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1506454499.797509-1446205962', '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 12:42:27 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 12:42:27 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 12:42:27 INFO - Using env: {'DISPLAY': ':0', 12:42:27 INFO - 'HOME': '/home/cltbld', 12:42:27 INFO - 'LANG': 'en_US.UTF-8', 12:42:27 INFO - 'LANGUAGE': 'en_US:en', 12:42:27 INFO - 'LOGNAME': 'cltbld', 12:42:27 INFO - 'MAIL': '/var/mail/cltbld', 12:42:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:42:27 INFO - 'MOZ_NO_REMOTE': '1', 12:42:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:42:27 INFO - 'NO_EM_RESTART': '1', 12:42:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:42:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:42:27 INFO - 'PWD': '/builds/slave/test', 12:42:27 INFO - 'SHELL': '/bin/bash', 12:42:27 INFO - 'SHLVL': '1', 12:42:27 INFO - 'TERM': 'linux', 12:42:27 INFO - 'TMOUT': '86400', 12:42:27 INFO - 'USER': 'cltbld', 12:42:27 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1506454499.797509-1446205962', 12:42:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:42:27 INFO - '_': '/tools/buildbot/bin/python'} 12:42:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:42:27 INFO - Downloading/unpacking psutil>=3.1.1 12:42:27 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 12:42:27 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 12:42:27 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 12:42:27 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 12:42:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:42:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:42:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:42:35 INFO - Installing collected packages: psutil 12:42:35 INFO - Running setup.py install for psutil 12:42:35 INFO - building 'psutil._psutil_linux' extension 12:42:35 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 12:42:36 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 12:42:36 INFO - building 'psutil._psutil_posix' extension 12:42:36 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 12:42:36 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 12:42:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:42:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:42:36 INFO - Successfully installed psutil 12:42:36 INFO - Cleaning up... 12:42:36 INFO - Return code: 0 12:42:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:42: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')]} 12:42:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:42: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')]} 12:42:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:42:36 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 0xd1f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108c9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089d60>, '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 0x108aa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108aef0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1506454499.797509-1446205962', '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 12:42:36 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 12:42:36 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 12:42:36 INFO - Using env: {'DISPLAY': ':0', 12:42:36 INFO - 'HOME': '/home/cltbld', 12:42:36 INFO - 'LANG': 'en_US.UTF-8', 12:42:36 INFO - 'LANGUAGE': 'en_US:en', 12:42:36 INFO - 'LOGNAME': 'cltbld', 12:42:36 INFO - 'MAIL': '/var/mail/cltbld', 12:42:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:42:36 INFO - 'MOZ_NO_REMOTE': '1', 12:42:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:42:36 INFO - 'NO_EM_RESTART': '1', 12:42:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:42:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:42:36 INFO - 'PWD': '/builds/slave/test', 12:42:36 INFO - 'SHELL': '/bin/bash', 12:42:36 INFO - 'SHLVL': '1', 12:42:36 INFO - 'TERM': 'linux', 12:42:36 INFO - 'TMOUT': '86400', 12:42:36 INFO - 'USER': 'cltbld', 12:42:36 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1506454499.797509-1446205962', 12:42:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:42:36 INFO - '_': '/tools/buildbot/bin/python'} 12:42:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:42:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:42:36 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 12:42:36 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 12:42:36 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 12:42:36 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 12:42:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:42:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:42:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:42:37 INFO - Installing collected packages: mozsystemmonitor 12:42:37 INFO - Running setup.py install for mozsystemmonitor 12:42:37 INFO - Successfully installed mozsystemmonitor 12:42:37 INFO - Cleaning up... 12:42:37 INFO - Return code: 0 12:42:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:42:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:42:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:42:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:42:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:42:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xd1f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108c9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089d60>, '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 0x108aa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108aef0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1506454499.797509-1446205962', '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 12:42:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:42:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 12:42:37 INFO - Using env: {'DISPLAY': ':0', 12:42:37 INFO - 'HOME': '/home/cltbld', 12:42:37 INFO - 'LANG': 'en_US.UTF-8', 12:42:37 INFO - 'LANGUAGE': 'en_US:en', 12:42:37 INFO - 'LOGNAME': 'cltbld', 12:42:37 INFO - 'MAIL': '/var/mail/cltbld', 12:42:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:42:37 INFO - 'MOZ_NO_REMOTE': '1', 12:42:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:42:37 INFO - 'NO_EM_RESTART': '1', 12:42:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:42:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:42:37 INFO - 'PWD': '/builds/slave/test', 12:42:37 INFO - 'SHELL': '/bin/bash', 12:42:37 INFO - 'SHLVL': '1', 12:42:37 INFO - 'TERM': 'linux', 12:42:37 INFO - 'TMOUT': '86400', 12:42:37 INFO - 'USER': 'cltbld', 12:42:37 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1506454499.797509-1446205962', 12:42:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:42:37 INFO - '_': '/tools/buildbot/bin/python'} 12:42:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:42:38 INFO - Downloading/unpacking jsonschema==2.5.1 12:42:38 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 12:42:38 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 12:42:38 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 12:42:38 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 12:42:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:42:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:42:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:42:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:42:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:42:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:42:39 INFO - Downloading functools32-3.2.3-2.tar.gz 12:42:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:42:39 INFO - warning: no files found matching '*.txt' 12:42:39 INFO - no previously-included directories found matching 'build' 12:42:39 INFO - no previously-included directories found matching 'dist' 12:42:39 INFO - no previously-included directories found matching '.git*' 12:42:39 INFO - Installing collected packages: jsonschema, functools32 12:42:39 INFO - Running setup.py install for functools32 12:42:39 INFO - warning: no files found matching '*.txt' 12:42:39 INFO - no previously-included directories found matching 'build' 12:42:39 INFO - no previously-included directories found matching 'dist' 12:42:39 INFO - no previously-included directories found matching '.git*' 12:42:39 INFO - Successfully installed jsonschema functools32 12:42:39 INFO - Cleaning up... 12:42:39 INFO - Return code: 0 12:42:39 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:42:39 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')]} 12:42:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:42:39 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')]} 12:42:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:42:39 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 0xd1f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108c9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089d60>, '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 0x108aa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108aef0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1506454499.797509-1446205962', '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 12:42:39 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 12:42:39 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 12:42:39 INFO - Using env: {'DISPLAY': ':0', 12:42:39 INFO - 'HOME': '/home/cltbld', 12:42:39 INFO - 'LANG': 'en_US.UTF-8', 12:42:39 INFO - 'LANGUAGE': 'en_US:en', 12:42:39 INFO - 'LOGNAME': 'cltbld', 12:42:39 INFO - 'MAIL': '/var/mail/cltbld', 12:42:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:42:39 INFO - 'MOZ_NO_REMOTE': '1', 12:42:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:42:39 INFO - 'NO_EM_RESTART': '1', 12:42:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:42:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:42:39 INFO - 'PWD': '/builds/slave/test', 12:42:39 INFO - 'SHELL': '/bin/bash', 12:42:39 INFO - 'SHLVL': '1', 12:42:39 INFO - 'TERM': 'linux', 12:42:39 INFO - 'TMOUT': '86400', 12:42:39 INFO - 'USER': 'cltbld', 12:42:39 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1506454499.797509-1446205962', 12:42:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:42:39 INFO - '_': '/tools/buildbot/bin/python'} 12:42:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:42:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:42:39 INFO - Cleaning up... 12:42:39 INFO - Return code: 0 12:42:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:42:39 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')]} 12:42:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:42:39 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')]} 12:42:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:42:39 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 0xd1f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108c9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089d60>, '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 0x108aa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108aef0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1506454499.797509-1446205962', '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 12:42:39 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 12:42:39 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 12:42:39 INFO - Using env: {'DISPLAY': ':0', 12:42:39 INFO - 'HOME': '/home/cltbld', 12:42:39 INFO - 'LANG': 'en_US.UTF-8', 12:42:39 INFO - 'LANGUAGE': 'en_US:en', 12:42:39 INFO - 'LOGNAME': 'cltbld', 12:42:39 INFO - 'MAIL': '/var/mail/cltbld', 12:42:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:42:39 INFO - 'MOZ_NO_REMOTE': '1', 12:42:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:42:39 INFO - 'NO_EM_RESTART': '1', 12:42:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:42:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:42:39 INFO - 'PWD': '/builds/slave/test', 12:42:39 INFO - 'SHELL': '/bin/bash', 12:42:39 INFO - 'SHLVL': '1', 12:42:39 INFO - 'TERM': 'linux', 12:42:39 INFO - 'TMOUT': '86400', 12:42:39 INFO - 'USER': 'cltbld', 12:42:39 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1506454499.797509-1446205962', 12:42:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:42:39 INFO - '_': '/tools/buildbot/bin/python'} 12:42:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:42:39 INFO - Downloading/unpacking blobuploader==1.2.4 12:42:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:42:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:42:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:42:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:42:41 INFO - Downloading blobuploader-1.2.4.tar.gz 12:42:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:42:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:42:41 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 12:42:41 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 12:42:41 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 12:42:41 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 12:42:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:42:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:42:41 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 12:42:41 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 12:42:41 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 12:42:41 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 12:42:41 INFO - Downloading docopt-0.6.1.tar.gz 12:42:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:42:41 INFO - Installing collected packages: blobuploader, requests, docopt 12:42:41 INFO - Running setup.py install for blobuploader 12:42:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:42:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:42:41 INFO - Running setup.py install for requests 12:42:42 INFO - Running setup.py install for docopt 12:42:42 INFO - Successfully installed blobuploader requests docopt 12:42:42 INFO - Cleaning up... 12:42:42 INFO - Return code: 0 12:42:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:42:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:42:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:42:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:42:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:42:42 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 0xd1f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108c9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089d60>, '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 0x108aa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108aef0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1506454499.797509-1446205962', '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 12:42:42 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 12:42:42 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 12:42:42 INFO - Using env: {'DISPLAY': ':0', 12:42:42 INFO - 'HOME': '/home/cltbld', 12:42:42 INFO - 'LANG': 'en_US.UTF-8', 12:42:42 INFO - 'LANGUAGE': 'en_US:en', 12:42:42 INFO - 'LOGNAME': 'cltbld', 12:42:42 INFO - 'MAIL': '/var/mail/cltbld', 12:42:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:42:42 INFO - 'MOZ_NO_REMOTE': '1', 12:42:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:42:42 INFO - 'NO_EM_RESTART': '1', 12:42:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:42:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:42:42 INFO - 'PWD': '/builds/slave/test', 12:42:42 INFO - 'SHELL': '/bin/bash', 12:42:42 INFO - 'SHLVL': '1', 12:42:42 INFO - 'TERM': 'linux', 12:42:42 INFO - 'TMOUT': '86400', 12:42:42 INFO - 'USER': 'cltbld', 12:42:42 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1506454499.797509-1446205962', 12:42:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:42:42 INFO - '_': '/tools/buildbot/bin/python'} 12:42:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:42:42 INFO - Running setup.py (path:/tmp/pip-hZ3BYy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:42:42 INFO - Running setup.py (path:/tmp/pip-4RsHWG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:42:42 INFO - Running setup.py (path:/tmp/pip-T_p4kQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:42:42 INFO - Running setup.py (path:/tmp/pip-wDSzq4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:42:42 INFO - Running setup.py (path:/tmp/pip-vJWLqe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:42:42 INFO - Running setup.py (path:/tmp/pip-Dm_J10-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:42:42 INFO - Running setup.py (path:/tmp/pip-f7BRAg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:42:42 INFO - Running setup.py (path:/tmp/pip-sOtsrg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:42:43 INFO - Running setup.py (path:/tmp/pip-kVgtYy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:42:43 INFO - Running setup.py (path:/tmp/pip-_9bL9b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:42:43 INFO - Running setup.py (path:/tmp/pip-MMLqpo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:42:43 INFO - Running setup.py (path:/tmp/pip-GH5oix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:42:43 INFO - Running setup.py (path:/tmp/pip-UTbAgj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:42:43 INFO - Running setup.py (path:/tmp/pip-w9oBWv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:42:43 INFO - Running setup.py (path:/tmp/pip-7TFybw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:42:43 INFO - Running setup.py (path:/tmp/pip-nnL5pp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:42:43 INFO - Running setup.py (path:/tmp/pip-ztOVUC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:42:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:42:43 INFO - Running setup.py install for manifestparser 12:42:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:42:43 INFO - Running setup.py install for mozcrash 12:42:43 INFO - Running setup.py install for mozdebug 12:42:43 INFO - Running setup.py install for mozdevice 12:42:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:42:44 INFO - Running setup.py install for mozfile 12:42:44 INFO - Running setup.py install for mozhttpd 12:42:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:42:44 INFO - Running setup.py install for mozinfo 12:42:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:42:44 INFO - Running setup.py install for mozInstall 12:42:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:42:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:42:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:42:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:42:44 INFO - Running setup.py install for mozleak 12:42:44 INFO - Running setup.py install for mozlog 12:42:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:42:44 INFO - Running setup.py install for moznetwork 12:42:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:42:44 INFO - Running setup.py install for mozprocess 12:42:44 INFO - Running setup.py install for mozprofile 12:42:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:42:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:42:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:42:44 INFO - Running setup.py install for mozrunner 12:42:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:42:45 INFO - Running setup.py install for mozscreenshot 12:42:45 INFO - Running setup.py install for moztest 12:42:45 INFO - Running setup.py install for mozversion 12:42:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:42:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:42:45 INFO - Cleaning up... 12:42:45 INFO - Return code: 0 12:42:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:42:45 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')]} 12:42:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:42:45 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')]} 12:42:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:42:45 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 0xd1f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108c9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089d60>, '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 0x108aa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108aef0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1506454499.797509-1446205962', '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 12:42:45 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 12:42:45 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 12:42:45 INFO - Using env: {'DISPLAY': ':0', 12:42:45 INFO - 'HOME': '/home/cltbld', 12:42:45 INFO - 'LANG': 'en_US.UTF-8', 12:42:45 INFO - 'LANGUAGE': 'en_US:en', 12:42:45 INFO - 'LOGNAME': 'cltbld', 12:42:45 INFO - 'MAIL': '/var/mail/cltbld', 12:42:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:42:45 INFO - 'MOZ_NO_REMOTE': '1', 12:42:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:42:45 INFO - 'NO_EM_RESTART': '1', 12:42:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:42:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:42:45 INFO - 'PWD': '/builds/slave/test', 12:42:45 INFO - 'SHELL': '/bin/bash', 12:42:45 INFO - 'SHLVL': '1', 12:42:45 INFO - 'TERM': 'linux', 12:42:45 INFO - 'TMOUT': '86400', 12:42:45 INFO - 'USER': 'cltbld', 12:42:45 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1506454499.797509-1446205962', 12:42:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:42:45 INFO - '_': '/tools/buildbot/bin/python'} 12:42:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:42:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:42:45 INFO - Running setup.py (path:/tmp/pip-N1yj6W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:42:45 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)) 12:42:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:42:45 INFO - Running setup.py (path:/tmp/pip-_f7gO0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:42:45 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)) 12:42:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:42:45 INFO - Running setup.py (path:/tmp/pip-PzvAq4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:42:45 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)) 12:42:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:42:45 INFO - Running setup.py (path:/tmp/pip-NBnTqk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:42:45 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)) 12:42:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:42:45 INFO - Running setup.py (path:/tmp/pip-eUyqQs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:42:46 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)) 12:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:42:46 INFO - Running setup.py (path:/tmp/pip-1ovv8u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:42:46 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)) 12:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:42:46 INFO - Running setup.py (path:/tmp/pip-SWP2SZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:42:46 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)) 12:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:42:46 INFO - Running setup.py (path:/tmp/pip-6mdqyF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:42:46 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)) 12:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:42:46 INFO - Running setup.py (path:/tmp/pip-8AYGIj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:42:46 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)) 12:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:42:46 INFO - Running setup.py (path:/tmp/pip-IYIvcA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:42:46 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)) 12:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:42:46 INFO - Running setup.py (path:/tmp/pip-OJbtH6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:42:46 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)) 12:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:42:46 INFO - Running setup.py (path:/tmp/pip-xXUtXW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:42:46 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)) 12:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:42:46 INFO - Running setup.py (path:/tmp/pip-2I_a6E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:42:46 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)) 12:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:42:46 INFO - Running setup.py (path:/tmp/pip-va23oJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:42:46 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)) 12:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:42:46 INFO - Running setup.py (path:/tmp/pip-uqTsUS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:42:46 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)) 12:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:42:46 INFO - Running setup.py (path:/tmp/pip-ha8zyE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:42:46 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)) 12:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:42:46 INFO - Running setup.py (path:/tmp/pip-yAYF6x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:42:46 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)) 12:42:46 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)) 12:42:46 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)) 12:42:46 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)) 12:42:46 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)) 12:42:46 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)) 12:42:46 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)) 12:42:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:42:46 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 12:42:46 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 12:42:46 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 12:42:46 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 12:42:48 INFO - Downloading blessings-1.6.tar.gz 12:42:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:42:48 INFO - Installing collected packages: blessings 12:42:48 INFO - Running setup.py install for blessings 12:42:48 INFO - Successfully installed blessings 12:42:48 INFO - Cleaning up... 12:42:48 INFO - Return code: 0 12:42:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:42:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:42:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:42:48 INFO - Reading from file tmpfile_stdout 12:42:48 INFO - Current package versions: 12:42:48 INFO - argparse == 1.2.1 12:42:48 INFO - blessings == 1.6 12:42:48 INFO - blobuploader == 1.2.4 12:42:48 INFO - docopt == 0.6.1 12:42:48 INFO - functools32 == 3.2.3-2 12:42:48 INFO - jsonschema == 2.5.1 12:42:48 INFO - manifestparser == 1.1 12:42:48 INFO - mozInstall == 1.13 12:42:48 INFO - mozcrash == 1.0 12:42:48 INFO - mozdebug == 0.1 12:42:48 INFO - mozdevice == 0.51 12:42:48 INFO - mozfile == 1.2 12:42:48 INFO - mozhttpd == 0.7 12:42:48 INFO - mozinfo == 0.10 12:42:48 INFO - mozleak == 0.1 12:42:48 INFO - mozlog == 3.5 12:42:48 INFO - moznetwork == 0.27 12:42:48 INFO - mozprocess == 0.25 12:42:48 INFO - mozprofile == 0.28 12:42:48 INFO - mozrunner == 6.13 12:42:48 INFO - mozscreenshot == 0.1 12:42:48 INFO - mozsystemmonitor == 0.3 12:42:48 INFO - moztest == 0.8 12:42:48 INFO - mozversion == 1.4 12:42:48 INFO - psutil == 3.1.1 12:42:48 INFO - requests == 1.2.3 12:42:48 INFO - wsgiref == 0.1.2 12:42:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:42:48 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')]} 12:42:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:42:48 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')]} 12:42:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:42:48 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 0xd1f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108c9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089d60>, '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 0x108aa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108aef0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1506454499.797509-1446205962', '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 12:42:48 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 12:42:48 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 12:42:48 INFO - Using env: {'DISPLAY': ':0', 12:42:48 INFO - 'HOME': '/home/cltbld', 12:42:48 INFO - 'LANG': 'en_US.UTF-8', 12:42:48 INFO - 'LANGUAGE': 'en_US:en', 12:42:48 INFO - 'LOGNAME': 'cltbld', 12:42:48 INFO - 'MAIL': '/var/mail/cltbld', 12:42:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:42:48 INFO - 'MOZ_NO_REMOTE': '1', 12:42:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:42:48 INFO - 'NO_EM_RESTART': '1', 12:42:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:42:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:42:48 INFO - 'PWD': '/builds/slave/test', 12:42:48 INFO - 'SHELL': '/bin/bash', 12:42:48 INFO - 'SHLVL': '1', 12:42:48 INFO - 'TERM': 'linux', 12:42:48 INFO - 'TMOUT': '86400', 12:42:48 INFO - 'USER': 'cltbld', 12:42:48 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1506454499.797509-1446205962', 12:42:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:42:48 INFO - '_': '/tools/buildbot/bin/python'} 12:42:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:42:48 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)) 12:42:48 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)) 12:42:48 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)) 12:42:48 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)) 12:42:48 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)) 12:42:48 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)) 12:42:48 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)) 12:42:48 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)) 12:42:48 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)) 12:42:48 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 12:42:48 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 12:42:48 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 12:42:48 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 12:42:48 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 12:42:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 12:42:49 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)) 12:42:49 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)) 12:42:49 INFO - Installing collected packages: simplejson 12:42:49 INFO - Running setup.py install for simplejson 12:42:49 INFO - building 'simplejson._speedups' extension 12:42:49 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 12:42:50 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 12:42:50 INFO - Successfully installed simplejson 12:42:50 INFO - Cleaning up... 12:42:50 INFO - Return code: 0 12:42:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:42:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:42:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:42:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:42:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:42:50 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 0xd1f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108c9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089d60>, '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 0x108aa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108aef0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1506454499.797509-1446205962', '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 12:42:50 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 12:42:50 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 12:42:50 INFO - Using env: {'DISPLAY': ':0', 12:42:50 INFO - 'HOME': '/home/cltbld', 12:42:50 INFO - 'LANG': 'en_US.UTF-8', 12:42:50 INFO - 'LANGUAGE': 'en_US:en', 12:42:50 INFO - 'LOGNAME': 'cltbld', 12:42:50 INFO - 'MAIL': '/var/mail/cltbld', 12:42:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:42:50 INFO - 'MOZ_NO_REMOTE': '1', 12:42:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:42:50 INFO - 'NO_EM_RESTART': '1', 12:42:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:42:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:42:50 INFO - 'PWD': '/builds/slave/test', 12:42:50 INFO - 'SHELL': '/bin/bash', 12:42:50 INFO - 'SHLVL': '1', 12:42:50 INFO - 'TERM': 'linux', 12:42:50 INFO - 'TMOUT': '86400', 12:42:50 INFO - 'USER': 'cltbld', 12:42:50 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1506454499.797509-1446205962', 12:42:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:42:50 INFO - '_': '/tools/buildbot/bin/python'} 12:42:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:42:51 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:42:51 INFO - Cleaning up... 12:42:51 INFO - Return code: 0 12:42:51 INFO - Running post-action listener: _resource_record_post_action 12:42:51 INFO - Running post-action listener: _start_resource_monitoring 12:42:51 INFO - Starting resource monitoring. 12:42:51 INFO - [mozharness: 2017-09-26 19:42:51.184239Z] Finished create-virtualenv step (success) 12:42:51 INFO - [mozharness: 2017-09-26 19:42:51.184778Z] Running install step. 12:42:51 INFO - Running pre-action listener: _resource_record_pre_action 12:42:51 INFO - Running main action method: install 12:42:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:42:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:42:51 INFO - Reading from file tmpfile_stdout 12:42:51 INFO - Detecting whether we're running mozinstall >=1.0... 12:42:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:42:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:42:51 INFO - Reading from file tmpfile_stdout 12:42:51 INFO - Output received: 12:42:51 INFO - Usage: mozinstall [options] installer 12:42:51 INFO - Options: 12:42:51 INFO - -h, --help show this help message and exit 12:42:51 INFO - -d DEST, --destination=DEST 12:42:51 INFO - Directory to install application into. [default: 12:42:51 INFO - "/builds/slave/test"] 12:42:51 INFO - --app=APP Application being installed. [default: firefox] 12:42:51 INFO - mkdir: /builds/slave/test/build/application 12:42:51 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'] 12:42:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 12:43:09 INFO - Reading from file tmpfile_stdout 12:43:09 INFO - Output received: 12:43:09 INFO - /builds/slave/test/build/application/firefox/firefox 12:43:09 INFO - Running post-action listener: _resource_record_post_action 12:43:09 INFO - [mozharness: 2017-09-26 19:43:09.174671Z] Finished install step (success) 12:43:09 INFO - [mozharness: 2017-09-26 19:43:09.175013Z] Running setup-mitmproxy step. 12:43:09 INFO - Running pre-action listener: _resource_record_pre_action 12:43:09 INFO - Running main action method: setup_mitmproxy 12:43:09 INFO - Skipping: mitmproxy is not required 12:43:09 INFO - Running post-action listener: _resource_record_post_action 12:43:09 INFO - [mozharness: 2017-09-26 19:43:09.176712Z] Finished setup-mitmproxy step (success) 12:43:09 INFO - [mozharness: 2017-09-26 19:43:09.177028Z] Running run-tests step. 12:43:09 INFO - Running pre-action listener: _resource_record_pre_action 12:43:09 INFO - Running pre-action listener: _set_gcov_prefix 12:43:09 INFO - Running main action method: run_tests 12:43:09 WARNING - Try message not found. 12:43:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:43:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:43:09 INFO - Python 2.7.3 12:43:09 INFO - Return code: 0 12:43:09 INFO - grabbing minidump binary from tooltool 12:43:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:43:09 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 0x1089d60>, '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 0x108aa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108aef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:43:09 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 12:43:09 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 12:43:09 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 12:43:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:43:09 INFO - Return code: 0 12:43:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:43:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:43:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:43:09 INFO - ENV: RUST_BACKTRACE is now full 12:43:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:43:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:43:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JSqdHGsuRK2AZcN3JGZ2xg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-081', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-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 12:43:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JSqdHGsuRK2AZcN3JGZ2xg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-081 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log 12:43:09 INFO - Using env: {'DISPLAY': ':0', 12:43:09 INFO - 'HOME': '/home/cltbld', 12:43:09 INFO - 'LANG': 'en_US.UTF-8', 12:43:09 INFO - 'LANGUAGE': 'en_US:en', 12:43:09 INFO - 'LOGNAME': 'cltbld', 12:43:09 INFO - 'MAIL': '/var/mail/cltbld', 12:43:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:43:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:43:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:43:09 INFO - 'MOZ_NO_REMOTE': '1', 12:43:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:43:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:43:09 INFO - 'NO_EM_RESTART': '1', 12:43:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:43:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:43:09 INFO - 'PWD': '/builds/slave/test', 12:43:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:43:09 INFO - 'RUST_BACKTRACE': 'full', 12:43:09 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 12:43:09 INFO - 'SHELL': '/bin/bash', 12:43:09 INFO - 'SHLVL': '1', 12:43:09 INFO - 'TERM': 'linux', 12:43:09 INFO - 'TMOUT': '86400', 12:43:09 INFO - 'USER': 'cltbld', 12:43:09 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1506454499.797509-1446205962', 12:43:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:43:09 INFO - '_': '/tools/buildbot/bin/python'} 12:43:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JSqdHGsuRK2AZcN3JGZ2xg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-081', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] with output_timeout 3600 12:43:09 INFO - mozversion application_buildid: 20170926181431 12:43:09 INFO - mozversion application_changeset: 39aaf54972cb11a63815a96b532786133baa95bc 12:43:09 INFO - mozversion application_display_name: Nightly 12:43:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:43:09 INFO - mozversion application_name: Firefox 12:43:09 INFO - mozversion application_remotingname: firefox 12:43:09 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 12:43:09 INFO - mozversion application_vendor: Mozilla 12:43:09 INFO - mozversion application_version: 58.0a1 12:43:09 INFO - mozversion platform_buildid: 20170926181431 12:43:09 INFO - mozversion platform_changeset: 39aaf54972cb11a63815a96b532786133baa95bc 12:43:09 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 12:43:09 INFO - mozversion platform_version: 58.0a1 12:43:09 INFO - using testdate: 1506454989 12:43:09 INFO - actual date: 1506454989 12:43:09 INFO - starting webserver on 'localhost:37476' 12:43:09 INFO - SUITE-START | Running 2 tests 12:43:09 INFO - TEST-START | dromaeo_css 12:43:09 INFO - Initialising browser for dromaeo_css test... 12:43:09 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:37476/getInfo.html -profile /tmp/tmplymBEl/profile 12:43:09 INFO - TEST-INFO | started process 3265 (/builds/slave/test/build/application/firefox/firefox http://localhost:37476/getInfo.html) 12:43:15 INFO - TEST-INFO | 3265: exit 0 12:43:15 INFO - Browser initialized. 12:43:15 INFO - Running cycle 1/1 for dromaeo_css test... 12:43:15 INFO - Using env: {'DISPLAY': ':0', 12:43:15 INFO - 'HOME': '/home/cltbld', 12:43:15 INFO - 'JSGC_DISABLE_POISONING': '1', 12:43:15 INFO - 'LANG': 'en_US.UTF-8', 12:43:15 INFO - 'LANGUAGE': 'en_US:en', 12:43:15 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 12:43:15 INFO - 'LOGNAME': 'cltbld', 12:43:15 INFO - 'MAIL': '/var/mail/cltbld', 12:43:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:43:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:43:15 INFO - 'MOZ_CRASHREPORTER': '1', 12:43:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:43:15 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 12:43:15 INFO - 'MOZ_NO_REMOTE': '1', 12:43:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:43:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:43:15 INFO - 'NO_EM_RESTART': '1', 12:43:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:43:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:43:15 INFO - 'PWD': '/builds/slave/test', 12:43:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:43:15 INFO - 'RUST_BACKTRACE': 'full', 12:43:15 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 12:43:15 INFO - 'SHELL': '/bin/bash', 12:43:15 INFO - 'SHLVL': '1', 12:43:15 INFO - 'STYLO_FORCE_DISABLED': '1', 12:43:15 INFO - 'TERM': 'linux', 12:43:15 INFO - 'TMOUT': '86400', 12:43:15 INFO - 'USER': 'cltbld', 12:43:15 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1506454499.797509-1446205962', 12:43:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:43:15 INFO - '_': '/tools/buildbot/bin/python'} 12:43:15 INFO - TEST-INFO | started process 3501 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplymBEl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 12:43:16 INFO - PID 3501 | 12:43:16 INFO - PID 3501 | (/builds/slave/test/build/application/firefox/firefox:3551): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 12:43:16 INFO - PID 3501 | 12:43:26 INFO - PID 3501 | RSS: Main: 144838656 12:43:26 INFO - PID 3501 | 12:46:23 INFO - PID 3501 | Cycle 1(1): loaded http://localhost:37476/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37476/tests/dromaeo/cssquery-ext.html) 12:46:24 INFO - PID 3501 | RSS: Main: 146567168 12:46:24 INFO - PID 3501 | 12:49:26 INFO - PID 3501 | Cycle 1(1): loaded http://localhost:37476/tests/dromaeo/cssquery-ext.html (next: http://localhost:37476/tests/dromaeo/cssquery-jquery.html) 12:49:26 INFO - PID 3501 | RSS: Main: 146907136 12:49:26 INFO - PID 3501 | 12:52:28 INFO - PID 3501 | Cycle 1(1): loaded http://localhost:37476/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37476/tests/dromaeo/cssquery-mootools.html) 12:52:29 INFO - PID 3501 | RSS: Main: 148729856 12:52:29 INFO - PID 3501 | 12:55:30 INFO - PID 3501 | Cycle 1(1): loaded http://localhost:37476/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37476/tests/dromaeo/cssquery-prototype.html) 12:55:31 INFO - PID 3501 | RSS: Main: 145776640 12:55:31 INFO - PID 3501 | 12:58:34 INFO - PID 3501 | Cycle 1(1): loaded http://localhost:37476/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37476/tests/dromaeo/cssquery-yui.html) 12:58:34 INFO - PID 3501 | RSS: Main: 148832256 12:58:34 INFO - PID 3501 | 13:01:36 INFO - PID 3501 | Cycle 1(1): loaded http://localhost:37476/tests/dromaeo/cssquery-yui.html (next: http://localhost:37476/tests/dromaeo/cssquery-dojo.html) 13:01:36 INFO - PID 3501 | RSS: Main: 149446656 13:01:36 INFO - PID 3501 | 13:01:36 INFO - PID 3501 | __start_tp_report 13:01:36 INFO - PID 3501 | _x_x_mozilla_page_load 13:01:36 INFO - PID 3501 | _x_x_mozilla_page_load_details 13:01:36 INFO - PID 3501 | |i|pagename|runs| 13:01:36 INFO - PID 3501 | |0;dojo.html;3885.6114388561145;3895.6104389561046;3898.434726964588;3934.291827471055;3935.5277366716;6201.28685201202;6267.091271765591;6292.528060395472;6342.746290148394;6374.776882809097;6273.309935907047;6279.874402511947;6281.591696539733;6296.433321001109;6319.083732858733;5572.3034620672415;5697.829065128053;5713.228714123582;5718.256626638531;5719.170720245562;193.65324258452029;5671.149327600851;5727.312722473288;5758.3090029196555;5767.538596912237;5319.707416092114;5602.299712535933;5620.213170156161;5707.828765137053;5747.827565173052;5635.323761148688;5640.830775076754;5702.973464776339;5723.742431590546;5741.971290143564;5610.523105536035;5630.690312032836;5700.572457065737;5705.686187259699;5707.800226992077;6197.752089916398;6253.562250642457;6254.0618907163835;6307.873842523124;6352.650604216767;6713.4964877634375;6781.38967492928;6807.727690892359;6885.2770459101575;6896.586204827727;6844.5208835381545;6863.10779598654;6865.656717164122;6869.7595584154315;6874.175098988104;6267.780627678009;6356.9364306357265;6426.871462570769;6433.260175079832;6437.356264373525;6995.26549712283;7020.859582808315;7068.29317068289;7073.893891591631;7094;6612.768553100618;6693.163354580677;6716.227633822075;6795.286494917962;6804.08144900442;6804.625745583941;6806.285340039323;6825;6832.145981752281;6833.3166683331265;6657.966710166515;6662.7334906604165;6745.291744366771;6747.493937954575;6773.288804675537;6797.388235058868;6797.592144471348;6863.313668633096;6882.311768823178;6888.586684798928;4942.8764280893265;4984.675996060245;5026.84919452417;5045.672031317952;5059.873503162376;4454.020115574568;4495.820167193341;4529;4558.772061396917;4585.380973568593;6208.937910620836;6287.1198032275515;6301.936980630227;6302.873942521124;6308.684565771693;6682.097916781172;6771.289014653489;6830.487713421513;6844.623545705034;6858.348456896587;6173.32093469718;6200.720967556471;6254.562180647311;6256.624602523863;6277.591956522811;5481.205225242317;5546.77812887488;5554.416786237468;5559;5564.109742441271;6999.615021173884;7006.824829379204;7088.822779430452;7090.468214883905;7125.643717814089;6735.29279425663;6752.189737231563;6754.18949726036;6757.087793147862;6766.560173588701;7038.753643622448;7039.366457018893;7044.436445084279;7053.647317634201;7070.186928503288;6655.434288085567;6690.966545167243;6728.125343705483;6735.326467353226;6737.797866064026;6906.033155358154;6920;6924.238333783179;6925.099737034153;6939.826504337432;6577.14497115372;6586.967065164835;6601.273859875314;6685.33146685347;6708.597484150967;6471.644059576768;6483.7730679425995;6521.413072823469;6529.706163222571;6590.044443555754;6411.647359395278;6416.45460135875;6428.035794630843;6435.131257280207;6491.058796474579;6634.402903738686;6640.568363056386;6668.266490685924;6714.630695311609;6744.831379215559;6335.049742538656;6462.386073323027;6471.029345598198;6528.37980391862;6558.80323590293 13:01:36 INFO - PID 3501 | |1;ext.html;929.9953500232498;954.9761255968605;962.369647880638;970.1317320997707;977.6187286958083;42157;42787.35818962718;42792;42852;43067.138657226875;40190.39714404279;40508;40620.39069413961;40680.796596016975;40720.18559628806;7450.552966821981;7534.359579435727;7555.848883022336;7568.129665088502;7578.696852125936;7366.74216402426;7387.039684840963;7458.627068646573;7472.29013243741;7472.476926615139;7500.212477689845;8489.957550212272;8492.66029358825;8493.702720404786;8494.702685406011;8380.078191398941;8442.493450392934;8447.831043379098;8450.323974082059;8451;8101.6354264058255;8292.668293268262;8293.668253269861;8315.875261871077;8335.624896879655;40645.79677101625;40867.38698919518;40896;40906.79546602278;40938.59061409377;3637.781733096023;3672.485851980698;3683.613220611851;3697.4638677391895;3708.313961917027;33146.33707325864;33176.3364732704;33250.33499330024;33254.83372583146;33267.833660831544;5417.052015897202;5422.593305502063;5446.482584154499;5469.617126801126;5480.068388373986;217995;218092;218486;218606;219611;51522.22716659253;51911.480885190664;52264.21603675948;52296.738516307174;52388.11865347443;54794;54854;55107;55118.448815512136;55198;15829.604259893364;16186.109763963095;16195.43315983935;16204;16208.918955405148;12943.5469758558;12981.221126732426;12987.675308117372;13004.804927926089;13014.56839747627;15215.163166025975;15253.466128685664;15367.846321536865;15535.300911459011;15649.217539123227;5661.886762264814;5916.378780228014;5944.7919322824355;6010.248718910137;6064.240770449524;1089.1069323154936;1096.8354746788045;1099.7580532282884;1106.076426184129;1109.9500522476508;25459.236222913343;25543.361415964377;25553.872230638728;25751.742482574933;25817.48365032689;1209;1214.6659668591208;1216.4343580235056;1236.1285293867802;1237.5359240284893;13633.863661363457;13704.52034178799;13884.652883677989;13995.720085598232;13996.510122145675;262679;263153;263273;263446;263783;47885.5211447888;48586.75706621515;54560.181597276074;55671.721641392345;56069.71965140148;1496.3266530061517;1501.594569466238;1513.8334783174062;1515.545336399076;1519.6124988127956;30793.158626739947;30880.691193087783;31350.843245783624;31599.36801264008;31627;41196;41244.587554124075;41260.58739412567;41272.79363603163;41334.79332603318;233877;235042;235236;235301;236417;35898;36082.27835443224;36139;36153.27693446169;36377.63622363848;45478.77260613676;46253;46360.07279854451;46732;46982.29526557173;33810.49284260787;34012.82993585115;34185.48721769225;34497.65502344944;34521.482177766855;33727.49408758822;34101.317973640886;34270;34281.31437371189;34379.484307735904;39349.80325098356;39684.60315396925;39838.80080599579;40045.39931901082;40235;32527.51208731918;33155.50266745953;33169.336613267114;33633.327333453686;33718;25482.72586370711;25727.614085788355;25794.484110317313;25841.870790646677;26579.468410631292 13:01:36 INFO - PID 3501 | |2;jquery.html;597.9760809567617;602.6685323072309;609.5854818723273;610.9999999999999;612.5375341617079;23419.882900585493;24241.63637545436;24366.39084022898;24385.634215486738;24403.145889893858;21441.785582144214;23040.308790736264;23139.3058208254;23289.534209315803;23382.415439613975;6564.08102865598;6738.225104113017;6742.258351581322;6745.089412929266;6748.291429399916;6588.143541339619;6610.70251838666;6704.7988560343265;6924.23833378328;6929.826754331131;6849.280825513324;6850.623215723133;6852.828679283008;6858.554193977376;6860.416864566518;6564.93435065648;6850.21222559407;6866.759663411782;6871.415929645986;6875.656217189121;6362.840928976812;6364.2681091674585;6366.076918846741;6367.235931688227;6381.1066450696935;29539.852300738574;30134.69865301341;30169.245768855733;30176.84911575428;30194;2192.331338941622;2219.3896678413566;2221.244776775904;2224.343818573525;2227.164813195052;19845.702314465296;20198.596028079504;20741;20819.16723331065;20921.581568368547;2452.950940981188;2487.3905893056135;2542.580474221751;2549.1842610364693;2556.2842404126873;136708.31645841707;143005.28497357445;150182;154440;160826;15799.131047792253;15894.76157857633;16350.836491634931;16412.112607050105;16685.582860428345;26405.207843764332;26435.206943791716;26461.867690661424;26472.205833825017;26537;10403.063724264852;10464.52909619069;10535.525901334458;10621.2034097443;10798.352098873935;9455.858162127573;9611.663591774255;9705.805883882284;9717.61129554824;9751.658691945748;9781.853272200922;9889.505524723734;9899.752506187402;9936.354136981217;9989.850152247722;2840.67332256789;2861.871215795294;2922.853857307126;2963.199936017263;2972.1975066732293;1024.4416792847917;1032.912202462784;1044.5926088825365;1050.9421981790922;1051.3727639643262;20378.981050947394;20506.692399614018;20613.793862061488;20822.687659685118;20826.583468330547;1077.455884778182;1082.3451811653993;1091.579741799413;1098.319042193845;1114.9108071354271;10935;11163.609273675382;11262.662120136409;11277.54889804415;11365.943170284261;578773;592216;601993;614126;618406;124368;127988.36005820098;128014.35992820162;128218.35890820486;129369;1116.213069785799;1167.0780083733755;1200.6638141320445;1215.1068964311223;1263.570386068741;21028.47428814292;21258.681119782905;21447.57104857863;21459;21546.461338466663;57106.42893571011;57207;57592;58381.70809145927;58735.70632146812;71019.28980710334;71814.64092679504;71817.64091179511;73039;74609.62695186489;15077;15391.230438478255;15475.226238687796;15479.922600386926;15485.767713484533;23377.41556461034;23510.177143799883;23728.169514066925;23834.64248036246;23875.522489550458;19329.323473678352;19387.321443749403;19437.222511099397;19556.217751290358;19614.90192549028;17187.742183867;17376.565585860455;17380.21789019472;17642.294308227527;17929.37247196342;19970.70043949371;20001.499962501053;20202.191912323342;20250.89874550618;20291.391258262276;15026.173560453843;15035.398584056515;15071.4724984625;15176.772348415003;15210.46763363277;19181.32865349706;19421.4173574793;19496.122674479968;19618.019099045276;19639.52703547211 13:01:36 INFO - PID 3501 | |3;mootools.html;1409.830820301564;1444.4727674398841;1465.8754005909498;1466.6626675864557;1487.9181645009528;16702.665946681074;17325.826741732595;17342.739858902096;17356.218970146343;17358.39245626405;16991.065491397967;17133.14334283287;17136;17147.228374723138;17154.485365439024;2800.4819108465;2917.3581812001325;2918.1537354167267;2922.4301261254063;2924.327404696921;2749.312671832042;2894.6236989191375;2916.5041942869657;2921.5179495383236;2947.5726019727126;2966.3029188140767;2984.0451055662197;2991.5662228976785;2994.446027484911;2996.4306781711407;2796.091270337138;2805.6633204015548;2809.9157025289273;2814.2823579987075;2814.577813327997;2696.608991696213;2718.4563087382403;2746.0800631788375;2749.0515772058607;2760.0339881041677;16534.255958481775;16670.33318667252;16794.748078778826;16870.578235544086;16879.15604219784;8669.393142480028;8987.730368088967;8994.325425593106;9000.549972501349;9003.729888103368;5769.913451298234;6028.367021462727;6038.064100064497;6185.103160041814;6211.81364559064;2091.2994146960787;2122.225387733466;2136.8931553422267;2164.0694501364405;2174.847760656755;30163.849180753954;30495.542566861513;30504.237394065105;30580.694193058007;30586.082417527286;7319.41444684424;7547.73582924595;7579.696812127563;7643.312101910855;7684.769456916301;19073.80926190748;19330.03349832503;19347;19371;19376.515587110436;8536.317094632539;8797.648094076294;8801.207891289814;8804.295656347476;8808.735737927873;7855.371570274365;7934.365250779923;8039.35685145187;8115.4319197655595;8118.553479558563;5655.660660360391;5850.619709718854;5877.059670452707;5908.940910590925;5939.049752039653;1550.534839548131;1561.687662467511;1582.114016150959;1621.1164915121287;1629.1121338870344;975.9658411955689;981.3425005246502;985.2364417576435;989.0801554554333;1010.7372083258259;9327.207187389147;9459.905400945903;9525.333226674065;9546.331756777097;9551.522423878778;1030.6598822388594;1070.384528895888;1079.4764539198482;1080.4597701149426;1085.3542142425244;5332.213708407649;5378.220158077135;6128.6016408934165;6158.538109641795;6179;23863.52272954531;24671.876640616683;24788.008479660613;24880.75119248784;24911.252662420156;23120.42198945006;24580;25255.494890102094;25255.62116568253;25334.493310133694;12738.617841464771;12747.808782868264;12774.936125319315;12833.294168820617;12930.353482325847;9545.379550329206;9652.793400824898;9732.41605503672;9837.213022958003;9861.852072218779;21017.264395746075;21328.893355533124;21496.462588434788;21836.45408864791;21874.45313867166;21491.677624835327;21795;22027.559448811255;22040.11839526465;22518.099276028774;12326.938365308117;12568.120231584067;12579.182353147016;12603.621891343275;12611.49554017829;15391.69216615639;15462.226888655747;15595.532134035997;15724.056556606183;15858.365665373256;11718.765624687629;11871.940640296743;11975.880241197476;12201.877981220074;12280.38598070075;11944.701382465508;12097.57658481949;12331.321777301975;12444.128910976146;12544.24734515932;10509.789804204025;10551.94724026375;10643.627473038407;10657.14742820557;10674.092702120406;8617.439866408915;8652.351073669373;8709.608067636846;8744.08187140341;8782.516961567175;8850.114988501356;8858.557072146496;8902.55487225649;8948.105189481;9016.729498115066 13:01:36 INFO - PID 3501 | |4;prototype.html;539.16967869481;556.5770014788765;561.6349372907607;581.6248519704791;586.284732626196;6314.368563143695;6319.936800631992;6330.525210609211;6407.647579383138;6411.326810684869;6149.877002459948;6191.133241346215;6222.688865556715;6291.559590828644;6307.747690092402;5061;5117.360329958755;5120.743962801864;5140.768665410047;5153.587712982952;5078.390593128811;5112.718800465973;5117.820876269331;5121.28302037715;5147.27938088666;4779.64152688548;4874.512548745132;4910.140725373063;4973.5772459341;5064.468230835764;4904;4910.042541704387;4958.231474121517;4973.801047958077;4985.601151907838;4455.688101832873;4491.281394976821;4495.123450927071;4503.459584849807;4529.116822219668;5960.493358064569;6024.518038556905;6045.153678485016;6070.726817293233;6129.877402451926;5710.486056254957;5730.7707691692285;5743.16724075011;5802.419758024206;5809;6654.602533467977;6669.633170175638;6684.866302673968;6703.698333574952;6710.899336509956;4850.320955066293;5026.2711906773675;5029.597632189416;5051.26756620288;5052.317937078521;6779.694913728894;6782.423494003016;6888.242293347727;6924.58452492852;6934.341237582422;5122.846314610568;5179.093658609729;5186.714730689849;5190.870228244248;5193.532582067556;5209.7395130244095;5220.712860792617;5248.687828042989;5255.658382205144;5279.260903473517;5772.3650398456975;5780.884382312414;5806.287145292149;5811.418858114154;5812.651240925558;6678.165229346332;6704.83237919056;6720.1599800025;6738.191417029988;6761;1810.393518171401;1811.601447681508;1818;1819.4814477874006;1828.5645768072;1225.9019278457702;1264.3488603369271;1291.9354032298347;1301.5965050834081;1309.1752196116577;6048.637081775108;6063.120847477179;6122.877542449126;6165.164024548668;6185.41238582334;6597.274299827015;6700.128983232246;6716.865662686817;6729.360710732472;6731.528792984542;6033.4871535919065;6063.787767428207;6106.511479081662;6114.174586430864;6151.9384806151365;3507.5440192774777;3520.2607452435277;3563.518924945099;3565.4117070683565;3576.624454432299;6982.301769822977;6997.4052205562075;7001.404880585207;7029.578225306498;7070.36366726997;6853.7943861684225;6907.827304317432;6933.162711881356;6951.513394062468;6969.9303006969285;7043.8239044023285;7049.330313620198;7079.752208672672;7082.114735658043;7094.9290507094265;6755.2231493378895;6760.391564759196;6789.388954994074;6816.522843400914;6860.2453730088655;6622.503312251697;6747.493937954575;6757.087793147862;6776.864462710817;6801.89797153053;6962.582245065312;7007.649617519001;7020.157581090098;7048.577085374894;7060.7881763547175;5103.8468845934685;5132.692038477703;5135.768890399866;5163.251328557413;5187.636865419385;6469.353064693493;6502.447291980235;6781.152355955505;6782.423494002867;6834.692438840363;6538.215414150332;6546.705398256994;6549.279579246184;6576.8490514158875;6593.109930159559;6448.709808058555;6476.481881449567;6559.6064236145985;6573.3098024706715;6598.439132673777;6381.840453988688;6411.326810684997;6438.3883531064475;6448.193975753031;6455.7740479083;6465.806025819233;6509.7396104155305;6531.706073226621;6593.241777195684;6658.83352916181;6381.266154392119;6395.688883778721;6456.225252969673;6475.773347932988;6539 13:01:36 INFO - PID 3501 | |5;yui.html;975.512243878061;976.5361453309679;1000.44975263605;1009.8535712321718;1011.3931641015389;17576;17724.91137544312;17774.555636109104;17806.643867122682;19034.238630454784;17872.731909021342;18017.909910450464;18045.187966541504;18065.7290140648;18091.728624070616;1058.2169194795872;1064.6327017179099;1066.807974564578;1073.9946300268527;1074.4198133008167;1073.5920350266927;1074.2963358999868;1074.3392813419769;1076.7523469601997;1077.805994920914;1006.0392325329293;1116.776644671065;1117.9608713695022;1122.764219513903;1129.2546919033439;1124.8706398764166;1125.1561329003289;1125.482278152051;1125.6679279612533;1127.143371038013;793.317746737805;823.625250511016;825.640846231885;825.8389614025267;826.5123577089486;18570.442886713285;18959.62080758377;19031.048447577567;19108.713369299472;19141.330053448062;22859.88570057139;22893;23626.17308394215;23759.406014849596;23808;18329.08354582279;18463.907680461645;18663;18707.34524291657;18796.530086747804;3882.456456096149;3923.7645741255615;3945.4870866787132;3948.9930067832806;3949.605039496056;128875;160459;160910;162929;166653;14923.40306387754;15140.470083547023;15212.771808422882;15230.923845380703;15258.313375898111;27231.455370892472;27319.726802732115;28305.858470707513;28536.14391568256;28555.143345699664;8792.692255771017;8961.731148065568;8985.685501007434;8986.640534378552;9002.909970900208;4344.543822898613;4401.867943961686;4415.116976604628;4437.445319335083;4438;5945.613535120204;6007.789727359522;6063.454289114001;6088.573799834057;6108.5723999319625;1244.3591550351575;1262.2300396757971;1269.3970364077175;1272.401971073594;1273.4778740716263;728.8287252495659;733.1312394812164;749.7450866705346;756.5082696247483;760.5322726523259;12937.417816198295;13727.588172354845;13769.931150344184;14109.576712698636;14198.787018194735;721.9639018049077;726.3753172271842;728.7412968396249;738.5605564689001;744.8733715268309;6303.684815759194;6328.683565821782;6330.240371155399;6351.777687780906;6353.36466353361;144639;145263;145712.2714386421;145740;146233;129588.3520582391;132030;132452.33773831069;133461;134973;104782.47608761907;106794;107824.4608776951;107892.46053769681;110316.448417759;11447.198696091195;11663.358515281401;11869.940650296694;11902.345371004332;11956.701082473008;54961;55672.16491752708;56199;56971.71514142403;57632;72071.27928720856;72526.27473725195;72871.63564182146;73787.26212738019;75291.62354188412;17603.239676032295;17760;17950.19224134891;18080.54798629992;18171.727424088385;19979.300724474575;20047;20239.79760202379;20251;20278.493037673587;17775.46673599794;17886.373976910745;17894.642107157524;18160.72758908591;18171.727424088385;18554.44336669902;18711;18770.343037993604;18814.435566933014;18971.810281897557;17275.481735547954;17316.82683173152;17333.306667733654;17511.124443778015;17513;13378.665533361744;13405.530806421728;13488.93255533716;13507.39216735269;13757.724845502833;13818.378172982038;13922.930385348414;13932.233727145105;14077.718445631235;14083.718325633225 13:01:36 INFO - PID 3501 | __end_tp_report 13:01:36 INFO - PID 3501 | __start_cc_report 13:01:36 INFO - PID 3501 | _x_x_mozilla_cycle_collect,265 13:01:36 INFO - PID 3501 | __end_cc_report 13:01:36 INFO - PID 3501 | __startTimestamp1506456096526__endTimestamp 13:01:36 INFO - PID 3501 | 13:01:36 INFO - PID 3501 | ------- Summary: start ------- 13:01:36 INFO - PID 3501 | Number of tests: 6 13:01:36 INFO - PID 3501 | 13:01:36 INFO - PID 3501 | [#0] dojo.html Cycles:165 Average:6238.95 Median:6471.64 stddev:873.10 (13.5%) stddev-sans-first:856.03 13:01:36 INFO - PID 3501 | Values: 3885.6 3895.6 3898.4 3934.3 3935.5 6201.3 6267.1 6292.5 6342.7 6374.8 6273.3 6279.9 6281.6 6296.4 6319.1 5572.3 5697.8 5713.2 5718.3 5719.2 193.7 5671.1 5727.3 5758.3 5767.5 5319.7 5602.3 5620.2 5707.8 5747.8 5635.3 5640.8 5703.0 5723.7 5742.0 5610.5 5630.7 5700.6 5705.7 5707.8 6197.8 6253.6 6254.1 6307.9 6352.7 6713.5 6781.4 6807.7 6885.3 6896.6 6844.5 6863.1 6865.7 6869.8 6874.2 6267.8 6356.9 6426.9 6433.3 6437.4 6995.3 7020.9 7068.3 7073.9 7094.0 6612.8 6693.2 6716.2 6795.3 6804.1 6804.6 6806.3 6825.0 6832.1 6833.3 6658.0 6662.7 6745.3 6747.5 6773.3 6797.4 6797.6 6863.3 6882.3 6888.6 4942.9 4984.7 5026.8 5045.7 5059.9 4454.0 4495.8 4529.0 4558.8 4585.4 6208.9 6287.1 6301.9 6302.9 6308.7 6682.1 6771.3 6830.5 6844.6 6858.3 6173.3 6200.7 6254.6 6256.6 6277.6 5481.2 5546.8 5554.4 5559.0 5564.1 6999.6 7006.8 7088.8 7090.5 7125.6 6735.3 6752.2 6754.2 6757.1 6766.6 7038.8 7039.4 7044.4 7053.6 7070.2 6655.4 6691.0 6728.1 6735.3 6737.8 6906.0 6920.0 6924.2 6925.1 6939.8 6577.1 6587.0 6601.3 6685.3 6708.6 6471.6 6483.8 6521.4 6529.7 6590.0 6411.6 6416.5 6428.0 6435.1 6491.1 6634.4 6640.6 6668.3 6714.6 6744.8 6335.0 6462.4 6471.0 6528.4 6558.8 13:01:36 INFO - PID 3501 | 13:01:36 INFO - PID 3501 | [#1] ext.html Cycles:180 Average:41669.30 Median:20025.06 stddev:62173.07 (310.5%) stddev-sans-first:62272.23 13:01:36 INFO - PID 3501 | Values: 930.0 955.0 962.4 970.1 977.6 42157.0 42787.4 42792.0 42852.0 43067.1 40190.4 40508.0 40620.4 40680.8 40720.2 7450.6 7534.4 7555.8 7568.1 7578.7 7366.7 7387.0 7458.6 7472.3 7472.5 7500.2 8490.0 8492.7 8493.7 8494.7 8380.1 8442.5 8447.8 8450.3 8451.0 8101.6 8292.7 8293.7 8315.9 8335.6 40645.8 40867.4 40896.0 40906.8 40938.6 3637.8 3672.5 3683.6 3697.5 3708.3 33146.3 33176.3 33250.3 33254.8 33267.8 5417.1 5422.6 5446.5 5469.6 5480.1 217995.0 218092.0 218486.0 218606.0 219611.0 51522.2 51911.5 52264.2 52296.7 52388.1 54794.0 54854.0 55107.0 55118.4 55198.0 15829.6 16186.1 16195.4 16204.0 16208.9 12943.5 12981.2 12987.7 13004.8 13014.6 15215.2 15253.5 15367.8 15535.3 15649.2 5661.9 5916.4 5944.8 6010.2 6064.2 1089.1 1096.8 1099.8 1106.1 1110.0 25459.2 25543.4 25553.9 25751.7 25817.5 1209.0 1214.7 1216.4 1236.1 1237.5 13633.9 13704.5 13884.7 13995.7 13996.5 262679.0 263153.0 263273.0 263446.0 263783.0 47885.5 48586.8 54560.2 55671.7 56069.7 1496.3 1501.6 1513.8 1515.5 1519.6 30793.2 30880.7 31350.8 31599.4 31627.0 41196.0 41244.6 41260.6 41272.8 41334.8 233877.0 235042.0 235236.0 235301.0 236417.0 35898.0 36082.3 36139.0 36153.3 36377.6 45478.8 46253.0 46360.1 46732.0 46982.3 33810.5 34012.8 34185.5 34497.7 34521.5 33727.5 34101.3 34270.0 34281.3 34379.5 39349.8 39684.6 39838.8 40045.4 40235.0 32527.5 33155.5 33169.3 33633.3 33718.0 25482.7 25727.6 25794.5 25841.9 26579.5 13:01:36 INFO - PID 3501 | 13:01:36 INFO - PID 3501 | [#2] jquery.html Cycles:180 Average:39092.91 Median:12633.74 stddev:100435.14 (795.0%) stddev-sans-first:100675.30 13:01:36 INFO - PID 3501 | Values: 598.0 602.7 609.6 611.0 612.5 23419.9 24241.6 24366.4 24385.6 24403.1 21441.8 23040.3 23139.3 23289.5 23382.4 6564.1 6738.2 6742.3 6745.1 6748.3 6588.1 6610.7 6704.8 6924.2 6929.8 6849.3 6850.6 6852.8 6858.6 6860.4 6564.9 6850.2 6866.8 6871.4 6875.7 6362.8 6364.3 6366.1 6367.2 6381.1 29539.9 30134.7 30169.2 30176.8 30194.0 2192.3 2219.4 2221.2 2224.3 2227.2 19845.7 20198.6 20741.0 20819.2 20921.6 2453.0 2487.4 2542.6 2549.2 2556.3 136708.3 143005.3 150182.0 154440.0 160826.0 15799.1 15894.8 16350.8 16412.1 16685.6 26405.2 26435.2 26461.9 26472.2 26537.0 10403.1 10464.5 10535.5 10621.2 10798.4 9455.9 9611.7 9705.8 9717.6 9751.7 9781.9 9889.5 9899.8 9936.4 9989.9 2840.7 2861.9 2922.9 2963.2 2972.2 1024.4 1032.9 1044.6 1050.9 1051.4 20379.0 20506.7 20613.8 20822.7 20826.6 1077.5 1082.3 1091.6 1098.3 1114.9 10935.0 11163.6 11262.7 11277.5 11365.9 578773.0 592216.0 601993.0 614126.0 618406.0 124368.0 127988.4 128014.4 128218.4 129369.0 1116.2 1167.1 1200.7 1215.1 1263.6 21028.5 21258.7 21447.6 21459.0 21546.5 57106.4 57207.0 57592.0 58381.7 58735.7 71019.3 71814.6 71817.6 73039.0 74609.6 15077.0 15391.2 15475.2 15479.9 15485.8 23377.4 23510.2 23728.2 23834.6 23875.5 19329.3 19387.3 19437.2 19556.2 19614.9 17187.7 17376.6 17380.2 17642.3 17929.4 19970.7 20001.5 20202.2 20250.9 20291.4 15026.2 15035.4 15071.5 15176.8 15210.5 19181.3 19421.4 19496.1 19618.0 19639.5 13:01:36 INFO - PID 3501 | 13:01:36 INFO - PID 3501 | [#3] mootools.html Cycles:180 Average:10523.69 Median:14015.55 stddev:7648.17 (54.6%) stddev-sans-first:7638.98 13:01:36 INFO - PID 3501 | Values: 1409.8 1444.5 1465.9 1466.7 1487.9 16702.7 17325.8 17342.7 17356.2 17358.4 16991.1 17133.1 17136.0 17147.2 17154.5 2800.5 2917.4 2918.2 2922.4 2924.3 2749.3 2894.6 2916.5 2921.5 2947.6 2966.3 2984.0 2991.6 2994.4 2996.4 2796.1 2805.7 2809.9 2814.3 2814.6 2696.6 2718.5 2746.1 2749.1 2760.0 16534.3 16670.3 16794.7 16870.6 16879.2 8669.4 8987.7 8994.3 9000.5 9003.7 5769.9 6028.4 6038.1 6185.1 6211.8 2091.3 2122.2 2136.9 2164.1 2174.8 30163.8 30495.5 30504.2 30580.7 30586.1 7319.4 7547.7 7579.7 7643.3 7684.8 19073.8 19330.0 19347.0 19371.0 19376.5 8536.3 8797.6 8801.2 8804.3 8808.7 7855.4 7934.4 8039.4 8115.4 8118.6 5655.7 5850.6 5877.1 5908.9 5939.0 1550.5 1561.7 1582.1 1621.1 1629.1 976.0 981.3 985.2 989.1 1010.7 9327.2 9459.9 9525.3 9546.3 9551.5 1030.7 1070.4 1079.5 1080.5 1085.4 5332.2 5378.2 6128.6 6158.5 6179.0 23863.5 24671.9 24788.0 24880.8 24911.3 23120.4 24580.0 25255.5 25255.6 25334.5 12738.6 12747.8 12774.9 12833.3 12930.4 9545.4 9652.8 9732.4 9837.2 9861.9 21017.3 21328.9 21496.5 21836.5 21874.5 21491.7 21795.0 22027.6 22040.1 22518.1 12326.9 12568.1 12579.2 12603.6 12611.5 15391.7 15462.2 15595.5 15724.1 15858.4 11718.8 11871.9 11975.9 12201.9 12280.4 11944.7 12097.6 12331.3 12444.1 12544.2 10509.8 10551.9 10643.6 10657.1 10674.1 8617.4 8652.4 8709.6 8744.1 8782.5 8850.1 8858.6 8902.6 8948.1 9016.7 13:01:36 INFO - PID 3501 | 13:01:36 INFO - PID 3501 | [#4] prototype.html Cycles:180 Average:5624.83 Median:6188.27 stddev:1576.37 (25.5%) stddev-sans-first:1533.89 13:01:36 INFO - PID 3501 | Values: 539.2 556.6 561.6 581.6 586.3 6314.4 6319.9 6330.5 6407.6 6411.3 6149.9 6191.1 6222.7 6291.6 6307.7 5061.0 5117.4 5120.7 5140.8 5153.6 5078.4 5112.7 5117.8 5121.3 5147.3 4779.6 4874.5 4910.1 4973.6 5064.5 4904.0 4910.0 4958.2 4973.8 4985.6 4455.7 4491.3 4495.1 4503.5 4529.1 5960.5 6024.5 6045.2 6070.7 6129.9 5710.5 5730.8 5743.2 5802.4 5809.0 6654.6 6669.6 6684.9 6703.7 6710.9 4850.3 5026.3 5029.6 5051.3 5052.3 6779.7 6782.4 6888.2 6924.6 6934.3 5122.8 5179.1 5186.7 5190.9 5193.5 5209.7 5220.7 5248.7 5255.7 5279.3 5772.4 5780.9 5806.3 5811.4 5812.7 6678.2 6704.8 6720.2 6738.2 6761.0 1810.4 1811.6 1818.0 1819.5 1828.6 1225.9 1264.3 1291.9 1301.6 1309.2 6048.6 6063.1 6122.9 6165.2 6185.4 6597.3 6700.1 6716.9 6729.4 6731.5 6033.5 6063.8 6106.5 6114.2 6151.9 3507.5 3520.3 3563.5 3565.4 3576.6 6982.3 6997.4 7001.4 7029.6 7070.4 6853.8 6907.8 6933.2 6951.5 6969.9 7043.8 7049.3 7079.8 7082.1 7094.9 6755.2 6760.4 6789.4 6816.5 6860.2 6622.5 6747.5 6757.1 6776.9 6801.9 6962.6 7007.6 7020.2 7048.6 7060.8 5103.8 5132.7 5135.8 5163.3 5187.6 6469.4 6502.4 6781.2 6782.4 6834.7 6538.2 6546.7 6549.3 6576.8 6593.1 6448.7 6476.5 6559.6 6573.3 6598.4 6381.8 6411.3 6438.4 6448.2 6455.8 6465.8 6509.7 6531.7 6593.2 6658.8 6381.3 6395.7 6456.2 6475.8 6539.0 13:01:36 INFO - PID 3501 | 13:01:36 INFO - PID 3501 | [#5] yui.html Cycles:180 Average:27638.03 Median:18055.46 stddev:41408.16 (229.3%) stddev-sans-first:41475.92 13:01:36 INFO - PID 3501 | Values: 975.5 976.5 1000.4 1009.9 1011.4 17576.0 17724.9 17774.6 17806.6 19034.2 17872.7 18017.9 18045.2 18065.7 18091.7 1058.2 1064.6 1066.8 1074.0 1074.4 1073.6 1074.3 1074.3 1076.8 1077.8 1006.0 1116.8 1118.0 1122.8 1129.3 1124.9 1125.2 1125.5 1125.7 1127.1 793.3 823.6 825.6 825.8 826.5 18570.4 18959.6 19031.0 19108.7 19141.3 22859.9 22893.0 23626.2 23759.4 23808.0 18329.1 18463.9 18663.0 18707.3 18796.5 3882.5 3923.8 3945.5 3949.0 3949.6 128875.0 160459.0 160910.0 162929.0 166653.0 14923.4 15140.5 15212.8 15230.9 15258.3 27231.5 27319.7 28305.9 28536.1 28555.1 8792.7 8961.7 8985.7 8986.6 9002.9 4344.5 4401.9 4415.1 4437.4 4438.0 5945.6 6007.8 6063.5 6088.6 6108.6 1244.4 1262.2 1269.4 1272.4 1273.5 728.8 733.1 749.7 756.5 760.5 12937.4 13727.6 13769.9 14109.6 14198.8 722.0 726.4 728.7 738.6 744.9 6303.7 6328.7 6330.2 6351.8 6353.4 144639.0 145263.0 145712.3 145740.0 146233.0 129588.4 132030.0 132452.3 133461.0 134973.0 104782.5 106794.0 107824.5 107892.5 110316.4 11447.2 11663.4 11869.9 11902.3 11956.7 54961.0 55672.2 56199.0 56971.7 57632.0 72071.3 72526.3 72871.6 73787.3 75291.6 17603.2 17760.0 17950.2 18080.5 18171.7 19979.3 20047.0 20239.8 20251.0 20278.5 17775.5 17886.4 17894.6 18160.7 18171.7 18554.4 18711.0 18770.3 18814.4 18971.8 17275.5 17316.8 17333.3 17511.1 17513.0 13378.7 13405.5 13488.9 13507.4 13757.7 13818.4 13922.9 13932.2 14077.7 14083.7 13:01:36 INFO - PID 3501 | -------- Summary: end -------- 13:01:36 INFO - PID 3501 | 13:01:37 INFO - TEST-INFO | 3501: exit 0 13:01:37 INFO - TEST-OK | dromaeo_css | took 1107660ms 13:01:37 INFO - TEST-START | kraken 13:01:37 INFO - Initialising browser for kraken test... 13:01:37 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:37476/getInfo.html -profile /tmp/tmp9H8642/profile 13:01:37 INFO - TEST-INFO | started process 3869 (/builds/slave/test/build/application/firefox/firefox http://localhost:37476/getInfo.html) 13:01:42 INFO - TEST-INFO | 3869: exit 0 13:01:42 INFO - Browser initialized. 13:01:42 INFO - Running cycle 1/1 for kraken test... 13:01:42 INFO - Using env: {'DISPLAY': ':0', 13:01:42 INFO - 'HOME': '/home/cltbld', 13:01:42 INFO - 'JSGC_DISABLE_POISONING': '1', 13:01:42 INFO - 'LANG': 'en_US.UTF-8', 13:01:42 INFO - 'LANGUAGE': 'en_US:en', 13:01:42 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 13:01:42 INFO - 'LOGNAME': 'cltbld', 13:01:42 INFO - 'MAIL': '/var/mail/cltbld', 13:01:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:01:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:01:42 INFO - 'MOZ_CRASHREPORTER': '1', 13:01:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:01:42 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 13:01:42 INFO - 'MOZ_NO_REMOTE': '1', 13:01:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:01:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:01:42 INFO - 'NO_EM_RESTART': '1', 13:01:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:01:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:01:42 INFO - 'PWD': '/builds/slave/test', 13:01:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:01:42 INFO - 'RUST_BACKTRACE': 'full', 13:01:42 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 13:01:42 INFO - 'SHELL': '/bin/bash', 13:01:42 INFO - 'SHLVL': '1', 13:01:42 INFO - 'STYLO_FORCE_DISABLED': '1', 13:01:42 INFO - 'TERM': 'linux', 13:01:42 INFO - 'TMOUT': '86400', 13:01:42 INFO - 'USER': 'cltbld', 13:01:42 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1506454499.797509-1446205962', 13:01:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:01:42 INFO - '_': '/tools/buildbot/bin/python'} 13:01:42 INFO - TEST-INFO | started process 4111 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9H8642/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 13:01:43 INFO - PID 4111 | 13:01:43 INFO - PID 4111 | (/builds/slave/test/build/application/firefox/firefox:4161): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 13:01:43 INFO - PID 4111 | 13:01:53 INFO - PID 4111 | RSS: Main: 144756736 13:01:53 INFO - PID 4111 | 13:01:56 INFO - PID 4111 | Cycle 1(1): loaded http://localhost:37476/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37476/tests/kraken/driver.html?testName=audio-beat-detection) 13:01:57 INFO - PID 4111 | RSS: Main: 151556096 13:01:57 INFO - PID 4111 | 13:01:59 INFO - PID 4111 | Cycle 1(1): loaded http://localhost:37476/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37476/tests/kraken/driver.html?testName=audio-dft) 13:02:00 INFO - PID 4111 | RSS: Main: 152076288 13:02:00 INFO - PID 4111 | 13:02:03 INFO - PID 4111 | Cycle 1(1): loaded http://localhost:37476/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37476/tests/kraken/driver.html?testName=audio-fft) 13:02:03 INFO - PID 4111 | RSS: Main: 147542016 13:02:03 INFO - PID 4111 | 13:02:05 INFO - PID 4111 | Cycle 1(1): loaded http://localhost:37476/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37476/tests/kraken/driver.html?testName=audio-oscillator) 13:02:06 INFO - PID 4111 | RSS: Main: 148553728 13:02:06 INFO - PID 4111 | 13:02:08 INFO - PID 4111 | Cycle 1(1): loaded http://localhost:37476/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37476/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:02:09 INFO - PID 4111 | RSS: Main: 148320256 13:02:09 INFO - PID 4111 | 13:02:12 INFO - PID 4111 | Cycle 1(1): loaded http://localhost:37476/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37476/tests/kraken/driver.html?testName=imaging-darkroom) 13:02:12 INFO - PID 4111 | RSS: Main: 148529152 13:02:12 INFO - PID 4111 | 13:02:16 INFO - PID 4111 | Cycle 1(1): loaded http://localhost:37476/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37476/tests/kraken/driver.html?testName=imaging-desaturate) 13:02:17 INFO - PID 4111 | RSS: Main: 149852160 13:02:17 INFO - PID 4111 | 13:02:19 INFO - PID 4111 | Cycle 1(1): loaded http://localhost:37476/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37476/tests/kraken/driver.html?testName=json-parse-financial) 13:02:20 INFO - PID 4111 | RSS: Main: 151486464 13:02:20 INFO - PID 4111 | 13:02:22 INFO - PID 4111 | Cycle 1(1): loaded http://localhost:37476/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37476/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:02:22 INFO - PID 4111 | RSS: Main: 151228416 13:02:22 INFO - PID 4111 | 13:02:24 INFO - PID 4111 | Cycle 1(1): loaded http://localhost:37476/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37476/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:02:24 INFO - PID 4111 | RSS: Main: 151474176 13:02:24 INFO - PID 4111 | 13:02:26 INFO - PID 4111 | Cycle 1(1): loaded http://localhost:37476/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37476/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:02:27 INFO - PID 4111 | RSS: Main: 148549632 13:02:27 INFO - PID 4111 | 13:02:29 INFO - PID 4111 | Cycle 1(1): loaded http://localhost:37476/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37476/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:02:30 INFO - PID 4111 | RSS: Main: 148602880 13:02:30 INFO - PID 4111 | 13:02:33 INFO - PID 4111 | Cycle 1(1): loaded http://localhost:37476/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37476/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:02:33 INFO - PID 4111 | RSS: Main: 149295104 13:02:33 INFO - PID 4111 | 13:02:35 INFO - PID 4111 | Cycle 1(1): loaded http://localhost:37476/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37476/tests/kraken/driver.html?testName=ai-astar) 13:02:35 INFO - PID 4111 | RSS: Main: 150630400 13:02:35 INFO - PID 4111 | 13:02:35 INFO - PID 4111 | __start_tp_report 13:02:35 INFO - PID 4111 | _x_x_mozilla_page_load 13:02:35 INFO - PID 4111 | _x_x_mozilla_page_load_details 13:02:35 INFO - PID 4111 | |i|pagename|runs| 13:02:35 INFO - PID 4111 | |0;ai-astar;106;105;104;105;108;111;109;105;105;109 13:02:35 INFO - PID 4111 | |1;audio-beat-detection;115;113;118;112;110;114;113;119;117;137 13:02:35 INFO - PID 4111 | |2;audio-dft;164;163;162;162;173;162;167;163;163;167 13:02:35 INFO - PID 4111 | |3;audio-fft;77;73;73;73;74;73;73;73;74;73 13:02:35 INFO - PID 4111 | |4;audio-oscillator;79;78;79;78;78;78;78;78;78;80 13:02:35 INFO - PID 4111 | |5;imaging-gaussian-blur;115;113;114;114;114;114;113;114;111;116 13:02:35 INFO - PID 4111 | |6;imaging-darkroom;151;149;149;151;150;151;151;151;150;149 13:02:35 INFO - PID 4111 | |7;imaging-desaturate;95;95;94;94;94;94;95;95;95;97 13:02:35 INFO - PID 4111 | |8;json-parse-financial;47;45;44;45;46;45;45;44;44;48 13:02:35 INFO - PID 4111 | |9;json-stringify-tinderbox;40;47;40;40;40;40;40;40;40;40 13:02:35 INFO - PID 4111 | |10;stanford-crypto-aes;75;72;70;69;71;71;69;70;71;69 13:02:35 INFO - PID 4111 | |11;stanford-crypto-ccm;112;104;104;112;110;106;109;107;107;103 13:02:35 INFO - PID 4111 | |12;stanford-crypto-pbkdf2;153;158;155;152;151;156;150;151;151;159 13:02:35 INFO - PID 4111 | |13;stanford-crypto-sha256-iterative;61;60;59;60;59;59;64;65;63;60 13:02:35 INFO - PID 4111 | __end_tp_report 13:02:35 INFO - PID 4111 | __start_cc_report 13:02:35 INFO - PID 4111 | _x_x_mozilla_cycle_collect,706 13:02:35 INFO - PID 4111 | __end_cc_report 13:02:35 INFO - PID 4111 | __startTimestamp1506456155844__endTimestamp 13:02:35 INFO - PID 4111 | 13:02:35 INFO - PID 4111 | ------- Summary: start ------- 13:02:35 INFO - PID 4111 | Number of tests: 14 13:02:35 INFO - PID 4111 | 13:02:35 INFO - PID 4111 | [#0] ai-astar Cycles:10 Average:106.70 Median:107.00 stddev:2.36 (2.2%) stddev-sans-first:2.49 13:02:35 INFO - PID 4111 | Values: 106.0 105.0 104.0 105.0 108.0 111.0 109.0 105.0 105.0 109.0 13:02:35 INFO - PID 4111 | 13:02:35 INFO - PID 4111 | [#1] audio-beat-detection Cycles:10 Average:116.80 Median:116.00 stddev:7.63 (6.6%) stddev-sans-first:8.06 13:02:35 INFO - PID 4111 | Values: 115.0 113.0 118.0 112.0 110.0 114.0 113.0 119.0 117.0 137.0 13:02:35 INFO - PID 4111 | 13:02:35 INFO - PID 4111 | [#2] audio-dft Cycles:10 Average:164.60 Median:163.50 stddev:3.50 (2.1%) stddev-sans-first:3.71 13:02:35 INFO - PID 4111 | Values: 164.0 163.0 162.0 162.0 173.0 162.0 167.0 163.0 163.0 167.0 13:02:35 INFO - PID 4111 | 13:02:35 INFO - PID 4111 | [#3] audio-fft Cycles:10 Average:73.60 Median:73.00 stddev:1.26 (1.7%) stddev-sans-first:0.44 13:02:35 INFO - PID 4111 | Values: 77.0 73.0 73.0 73.0 74.0 73.0 73.0 73.0 74.0 73.0 13:02:35 INFO - PID 4111 | 13:02:35 INFO - PID 4111 | [#4] audio-oscillator Cycles:10 Average:78.40 Median:78.00 stddev:0.70 (0.9%) stddev-sans-first:0.71 13:02:35 INFO - PID 4111 | Values: 79.0 78.0 79.0 78.0 78.0 78.0 78.0 78.0 78.0 80.0 13:02:35 INFO - PID 4111 | 13:02:35 INFO - PID 4111 | [#5] imaging-gaussian-blur Cycles:10 Average:113.80 Median:114.00 stddev:1.32 (1.2%) stddev-sans-first:1.32 13:02:35 INFO - PID 4111 | Values: 115.0 113.0 114.0 114.0 114.0 114.0 113.0 114.0 111.0 116.0 13:02:35 INFO - PID 4111 | 13:02:35 INFO - PID 4111 | [#6] imaging-darkroom Cycles:10 Average:150.20 Median:151.00 stddev:0.92 (0.6%) stddev-sans-first:0.93 13:02:35 INFO - PID 4111 | Values: 151.0 149.0 149.0 151.0 150.0 151.0 151.0 151.0 150.0 149.0 13:02:35 INFO - PID 4111 | 13:02:35 INFO - PID 4111 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.92 (1.0%) stddev-sans-first:0.97 13:02:35 INFO - PID 4111 | Values: 95.0 95.0 94.0 94.0 94.0 94.0 95.0 95.0 95.0 97.0 13:02:35 INFO - PID 4111 | 13:02:35 INFO - PID 4111 | [#8] json-parse-financial Cycles:10 Average:45.30 Median:45.00 stddev:1.34 (3.0%) stddev-sans-first:1.27 13:02:35 INFO - PID 4111 | Values: 47.0 45.0 44.0 45.0 46.0 45.0 45.0 44.0 44.0 48.0 13:02:35 INFO - PID 4111 | 13:02:35 INFO - PID 4111 | [#9] json-stringify-tinderbox Cycles:10 Average:40.70 Median:40.00 stddev:2.21 (5.5%) stddev-sans-first:2.33 13:02:35 INFO - PID 4111 | Values: 40.0 47.0 40.0 40.0 40.0 40.0 40.0 40.0 40.0 40.0 13:02:35 INFO - PID 4111 | 13:02:35 INFO - PID 4111 | [#10] stanford-crypto-aes Cycles:10 Average:70.70 Median:71.00 stddev:1.83 (2.6%) stddev-sans-first:1.09 13:02:35 INFO - PID 4111 | Values: 75.0 72.0 70.0 69.0 71.0 71.0 69.0 70.0 71.0 69.0 13:02:35 INFO - PID 4111 | 13:02:35 INFO - PID 4111 | [#11] stanford-crypto-ccm Cycles:10 Average:107.40 Median:108.00 stddev:3.27 (3.0%) stddev-sans-first:3.02 13:02:35 INFO - PID 4111 | Values: 112.0 104.0 104.0 112.0 110.0 106.0 109.0 107.0 107.0 103.0 13:02:35 INFO - PID 4111 | 13:02:35 INFO - PID 4111 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.60 Median:154.00 stddev:3.20 (2.1%) stddev-sans-first:3.39 13:02:35 INFO - PID 4111 | Values: 153.0 158.0 155.0 152.0 151.0 156.0 150.0 151.0 151.0 159.0 13:02:35 INFO - PID 4111 | 13:02:35 INFO - PID 4111 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.00 Median:60.50 stddev:2.21 (3.7%) stddev-sans-first:2.35 13:02:35 INFO - PID 4111 | Values: 61.0 60.0 59.0 60.0 59.0 59.0 64.0 65.0 63.0 60.0 13:02:35 INFO - PID 4111 | -------- Summary: end -------- 13:02:35 INFO - PID 4111 | 13:02:36 INFO - PID 4111 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 13:02:36 INFO - TEST-INFO | 4111: exit 0 13:02:36 INFO - TEST-OK | kraken | took 59302ms 13:02:36 INFO - SUITE-END | took 1166s 13:02:36 INFO - Completed test suite (00:19:26) 13:02:36 INFO - javascript benchmark 13:02:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9029.394871376755, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3885.6114388561145, 3895.6104389561046, 3898.434726964588, 3934.291827471055, 3935.5277366716, 6201.28685201202, 6267.091271765591, 6292.528060395472, 6342.746290148394, 6374.776882809097, 6273.309935907047, 6279.874402511947, 6281.591696539733, 6296.433321001109, 6319.083732858733, 5572.3034620672415, 5697.829065128053, 5713.228714123582, 5718.256626638531, 5719.170720245562, 193.65324258452029, 5671.149327600851, 5727.312722473288, 5758.3090029196555, 5767.538596912237, 5319.707416092114, 5602.299712535933, 5620.213170156161, 5707.828765137053, 5747.827565173052, 5635.323761148688, 5640.830775076754, 5702.973464776339, 5723.742431590546, 5741.971290143564, 5610.523105536035, 5630.690312032836, 5700.572457065737, 5705.686187259699, 5707.800226992077, 6197.752089916398, 6253.562250642457, 6254.0618907163835, 6307.873842523124, 6352.650604216767, 6713.4964877634375, 6781.38967492928, 6807.727690892359, 6885.2770459101575, 6896.586204827727, 6844.5208835381545, 6863.10779598654, 6865.656717164122, 6869.7595584154315, 6874.175098988104, 6267.780627678009, 6356.9364306357265, 6426.871462570769, 6433.260175079832, 6437.356264373525, 6995.26549712283, 7020.859582808315, 7068.29317068289, 7073.893891591631, 7094.0, 6612.768553100618, 6693.163354580677, 6716.227633822075, 6795.286494917962, 6804.08144900442, 6804.625745583941, 6806.285340039323, 6825.0, 6832.145981752281, 6833.3166683331265, 6657.966710166515, 6662.7334906604165, 6745.291744366771, 6747.493937954575, 6773.288804675537, 6797.388235058868, 6797.592144471348, 6863.313668633096, 6882.311768823178, 6888.586684798928, 4942.8764280893265, 4984.675996060245, 5026.84919452417, 5045.672031317952, 5059.873503162376, 4454.020115574568, 4495.820167193341, 4529.0, 4558.772061396917, 4585.380973568593, 6208.937910620836, 6287.1198032275515, 6301.936980630227, 6302.873942521124, 6308.684565771693, 6682.097916781172, 6771.289014653489, 6830.487713421513, 6844.623545705034, 6858.348456896587, 6173.32093469718, 6200.720967556471, 6254.562180647311, 6256.624602523863, 6277.591956522811, 5481.205225242317, 5546.77812887488, 5554.416786237468, 5559.0, 5564.109742441271, 6999.615021173884, 7006.824829379204, 7088.822779430452, 7090.468214883905, 7125.643717814089, 6735.29279425663, 6752.189737231563, 6754.18949726036, 6757.087793147862, 6766.560173588701, 7038.753643622448, 7039.366457018893, 7044.436445084279, 7053.647317634201, 7070.186928503288, 6655.434288085567, 6690.966545167243, 6728.125343705483, 6735.326467353226, 6737.797866064026, 6906.033155358154, 6920.0, 6924.238333783179, 6925.099737034153, 6939.826504337432, 6577.14497115372, 6586.967065164835, 6601.273859875314, 6685.33146685347, 6708.597484150967, 6471.644059576768, 6483.7730679425995, 6521.413072823469, 6529.706163222571, 6590.044443555754, 6411.647359395278, 6416.45460135875, 6428.035794630843, 6435.131257280207, 6491.058796474579, 6634.402903738686, 6640.568363056386, 6668.266490685924, 6714.630695311609, 6744.831379215559, 6335.049742538656, 6462.386073323027, 6471.029345598198, 6528.37980391862, 6558.80323590293], "value": 6182.992666559751, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [929.9953500232498, 954.9761255968605, 962.369647880638, 970.1317320997707, 977.6187286958083, 42157.0, 42787.35818962718, 42792.0, 42852.0, 43067.138657226875, 40190.39714404279, 40508.0, 40620.39069413961, 40680.796596016975, 40720.18559628806, 7450.552966821981, 7534.359579435727, 7555.848883022336, 7568.129665088502, 7578.696852125936, 7366.74216402426, 7387.039684840963, 7458.627068646573, 7472.29013243741, 7472.476926615139, 7500.212477689845, 8489.957550212272, 8492.66029358825, 8493.702720404786, 8494.702685406011, 8380.078191398941, 8442.493450392934, 8447.831043379098, 8450.323974082059, 8451.0, 8101.6354264058255, 8292.668293268262, 8293.668253269861, 8315.875261871077, 8335.624896879655, 40645.79677101625, 40867.38698919518, 40896.0, 40906.79546602278, 40938.59061409377, 3637.781733096023, 3672.485851980698, 3683.613220611851, 3697.4638677391895, 3708.313961917027, 33146.33707325864, 33176.3364732704, 33250.33499330024, 33254.83372583146, 33267.833660831544, 5417.052015897202, 5422.593305502063, 5446.482584154499, 5469.617126801126, 5480.068388373986, 217995.0, 218092.0, 218486.0, 218606.0, 219611.0, 51522.22716659253, 51911.480885190664, 52264.21603675948, 52296.738516307174, 52388.11865347443, 54794.0, 54854.0, 55107.0, 55118.448815512136, 55198.0, 15829.604259893364, 16186.109763963095, 16195.43315983935, 16204.0, 16208.918955405148, 12943.5469758558, 12981.221126732426, 12987.675308117372, 13004.804927926089, 13014.56839747627, 15215.163166025975, 15253.466128685664, 15367.846321536865, 15535.300911459011, 15649.217539123227, 5661.886762264814, 5916.378780228014, 5944.7919322824355, 6010.248718910137, 6064.240770449524, 1089.1069323154936, 1096.8354746788045, 1099.7580532282884, 1106.076426184129, 1109.9500522476508, 25459.236222913343, 25543.361415964377, 25553.872230638728, 25751.742482574933, 25817.48365032689, 1209.0, 1214.6659668591208, 1216.4343580235056, 1236.1285293867802, 1237.5359240284893, 13633.863661363457, 13704.52034178799, 13884.652883677989, 13995.720085598232, 13996.510122145675, 262679.0, 263153.0, 263273.0, 263446.0, 263783.0, 47885.5211447888, 48586.75706621515, 54560.181597276074, 55671.721641392345, 56069.71965140148, 1496.3266530061517, 1501.594569466238, 1513.8334783174062, 1515.545336399076, 1519.6124988127956, 30793.158626739947, 30880.691193087783, 31350.843245783624, 31599.36801264008, 31627.0, 41196.0, 41244.587554124075, 41260.58739412567, 41272.79363603163, 41334.79332603318, 233877.0, 235042.0, 235236.0, 235301.0, 236417.0, 35898.0, 36082.27835443224, 36139.0, 36153.27693446169, 36377.63622363848, 45478.77260613676, 46253.0, 46360.07279854451, 46732.0, 46982.29526557173, 33810.49284260787, 34012.82993585115, 34185.48721769225, 34497.65502344944, 34521.482177766855, 33727.49408758822, 34101.317973640886, 34270.0, 34281.31437371189, 34379.484307735904, 39349.80325098356, 39684.60315396925, 39838.80080599579, 40045.39931901082, 40235.0, 32527.51208731918, 33155.50266745953, 33169.336613267114, 33633.327333453686, 33718.0, 25482.72586370711, 25727.614085788355, 25794.484110317313, 25841.870790646677, 26579.468410631292], "value": 18421.337996567596, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [597.9760809567617, 602.6685323072309, 609.5854818723273, 610.9999999999999, 612.5375341617079, 23419.882900585493, 24241.63637545436, 24366.39084022898, 24385.634215486738, 24403.145889893858, 21441.785582144214, 23040.308790736264, 23139.3058208254, 23289.534209315803, 23382.415439613975, 6564.08102865598, 6738.225104113017, 6742.258351581322, 6745.089412929266, 6748.291429399916, 6588.143541339619, 6610.70251838666, 6704.7988560343265, 6924.23833378328, 6929.826754331131, 6849.280825513324, 6850.623215723133, 6852.828679283008, 6858.554193977376, 6860.416864566518, 6564.93435065648, 6850.21222559407, 6866.759663411782, 6871.415929645986, 6875.656217189121, 6362.840928976812, 6364.2681091674585, 6366.076918846741, 6367.235931688227, 6381.1066450696935, 29539.852300738574, 30134.69865301341, 30169.245768855733, 30176.84911575428, 30194.0, 2192.331338941622, 2219.3896678413566, 2221.244776775904, 2224.343818573525, 2227.164813195052, 19845.702314465296, 20198.596028079504, 20741.0, 20819.16723331065, 20921.581568368547, 2452.950940981188, 2487.3905893056135, 2542.580474221751, 2549.1842610364693, 2556.2842404126873, 136708.31645841707, 143005.28497357445, 150182.0, 154440.0, 160826.0, 15799.131047792253, 15894.76157857633, 16350.836491634931, 16412.112607050105, 16685.582860428345, 26405.207843764332, 26435.206943791716, 26461.867690661424, 26472.205833825017, 26537.0, 10403.063724264852, 10464.52909619069, 10535.525901334458, 10621.2034097443, 10798.352098873935, 9455.858162127573, 9611.663591774255, 9705.805883882284, 9717.61129554824, 9751.658691945748, 9781.853272200922, 9889.505524723734, 9899.752506187402, 9936.354136981217, 9989.850152247722, 2840.67332256789, 2861.871215795294, 2922.853857307126, 2963.199936017263, 2972.1975066732293, 1024.4416792847917, 1032.912202462784, 1044.5926088825365, 1050.9421981790922, 1051.3727639643262, 20378.981050947394, 20506.692399614018, 20613.793862061488, 20822.687659685118, 20826.583468330547, 1077.455884778182, 1082.3451811653993, 1091.579741799413, 1098.319042193845, 1114.9108071354271, 10935.0, 11163.609273675382, 11262.662120136409, 11277.54889804415, 11365.943170284261, 578773.0, 592216.0, 601993.0, 614126.0, 618406.0, 124368.0, 127988.36005820098, 128014.35992820162, 128218.35890820486, 129369.0, 1116.213069785799, 1167.0780083733755, 1200.6638141320445, 1215.1068964311223, 1263.570386068741, 21028.47428814292, 21258.681119782905, 21447.57104857863, 21459.0, 21546.461338466663, 57106.42893571011, 57207.0, 57592.0, 58381.70809145927, 58735.70632146812, 71019.28980710334, 71814.64092679504, 71817.64091179511, 73039.0, 74609.62695186489, 15077.0, 15391.230438478255, 15475.226238687796, 15479.922600386926, 15485.767713484533, 23377.41556461034, 23510.177143799883, 23728.169514066925, 23834.64248036246, 23875.522489550458, 19329.323473678352, 19387.321443749403, 19437.222511099397, 19556.217751290358, 19614.90192549028, 17187.742183867, 17376.565585860455, 17380.21789019472, 17642.294308227527, 17929.37247196342, 19970.70043949371, 20001.499962501053, 20202.191912323342, 20250.89874550618, 20291.391258262276, 15026.173560453843, 15035.398584056515, 15071.4724984625, 15176.772348415003, 15210.46763363277, 19181.32865349706, 19421.4173574793, 19496.122674479968, 19618.019099045276, 19639.52703547211], "value": 12641.896389430787, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1409.830820301564, 1444.4727674398841, 1465.8754005909498, 1466.6626675864557, 1487.9181645009528, 16702.665946681074, 17325.826741732595, 17342.739858902096, 17356.218970146343, 17358.39245626405, 16991.065491397967, 17133.14334283287, 17136.0, 17147.228374723138, 17154.485365439024, 2800.4819108465, 2917.3581812001325, 2918.1537354167267, 2922.4301261254063, 2924.327404696921, 2749.312671832042, 2894.6236989191375, 2916.5041942869657, 2921.5179495383236, 2947.5726019727126, 2966.3029188140767, 2984.0451055662197, 2991.5662228976785, 2994.446027484911, 2996.4306781711407, 2796.091270337138, 2805.6633204015548, 2809.9157025289273, 2814.2823579987075, 2814.577813327997, 2696.608991696213, 2718.4563087382403, 2746.0800631788375, 2749.0515772058607, 2760.0339881041677, 16534.255958481775, 16670.33318667252, 16794.748078778826, 16870.578235544086, 16879.15604219784, 8669.393142480028, 8987.730368088967, 8994.325425593106, 9000.549972501349, 9003.729888103368, 5769.913451298234, 6028.367021462727, 6038.064100064497, 6185.103160041814, 6211.81364559064, 2091.2994146960787, 2122.225387733466, 2136.8931553422267, 2164.0694501364405, 2174.847760656755, 30163.849180753954, 30495.542566861513, 30504.237394065105, 30580.694193058007, 30586.082417527286, 7319.41444684424, 7547.73582924595, 7579.696812127563, 7643.312101910855, 7684.769456916301, 19073.80926190748, 19330.03349832503, 19347.0, 19371.0, 19376.515587110436, 8536.317094632539, 8797.648094076294, 8801.207891289814, 8804.295656347476, 8808.735737927873, 7855.371570274365, 7934.365250779923, 8039.35685145187, 8115.4319197655595, 8118.553479558563, 5655.660660360391, 5850.619709718854, 5877.059670452707, 5908.940910590925, 5939.049752039653, 1550.534839548131, 1561.687662467511, 1582.114016150959, 1621.1164915121287, 1629.1121338870344, 975.9658411955689, 981.3425005246502, 985.2364417576435, 989.0801554554333, 1010.7372083258259, 9327.207187389147, 9459.905400945903, 9525.333226674065, 9546.331756777097, 9551.522423878778, 1030.6598822388594, 1070.384528895888, 1079.4764539198482, 1080.4597701149426, 1085.3542142425244, 5332.213708407649, 5378.220158077135, 6128.6016408934165, 6158.538109641795, 6179.0, 23863.52272954531, 24671.876640616683, 24788.008479660613, 24880.75119248784, 24911.252662420156, 23120.42198945006, 24580.0, 25255.494890102094, 25255.62116568253, 25334.493310133694, 12738.617841464771, 12747.808782868264, 12774.936125319315, 12833.294168820617, 12930.353482325847, 9545.379550329206, 9652.793400824898, 9732.41605503672, 9837.213022958003, 9861.852072218779, 21017.264395746075, 21328.893355533124, 21496.462588434788, 21836.45408864791, 21874.45313867166, 21491.677624835327, 21795.0, 22027.559448811255, 22040.11839526465, 22518.099276028774, 12326.938365308117, 12568.120231584067, 12579.182353147016, 12603.621891343275, 12611.49554017829, 15391.69216615639, 15462.226888655747, 15595.532134035997, 15724.056556606183, 15858.365665373256, 11718.765624687629, 11871.940640296743, 11975.880241197476, 12201.877981220074, 12280.38598070075, 11944.701382465508, 12097.57658481949, 12331.321777301975, 12444.128910976146, 12544.24734515932, 10509.789804204025, 10551.94724026375, 10643.627473038407, 10657.14742820557, 10674.092702120406, 8617.439866408915, 8652.351073669373, 8709.608067636846, 8744.08187140341, 8782.516961567175, 8850.114988501356, 8858.557072146496, 8902.55487225649, 8948.105189481, 9016.729498115066], "value": 7432.155728224123, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [539.16967869481, 556.5770014788765, 561.6349372907607, 581.6248519704791, 586.284732626196, 6314.368563143695, 6319.936800631992, 6330.525210609211, 6407.647579383138, 6411.326810684869, 6149.877002459948, 6191.133241346215, 6222.688865556715, 6291.559590828644, 6307.747690092402, 5061.0, 5117.360329958755, 5120.743962801864, 5140.768665410047, 5153.587712982952, 5078.390593128811, 5112.718800465973, 5117.820876269331, 5121.28302037715, 5147.27938088666, 4779.64152688548, 4874.512548745132, 4910.140725373063, 4973.5772459341, 5064.468230835764, 4904.0, 4910.042541704387, 4958.231474121517, 4973.801047958077, 4985.601151907838, 4455.688101832873, 4491.281394976821, 4495.123450927071, 4503.459584849807, 4529.116822219668, 5960.493358064569, 6024.518038556905, 6045.153678485016, 6070.726817293233, 6129.877402451926, 5710.486056254957, 5730.7707691692285, 5743.16724075011, 5802.419758024206, 5809.0, 6654.602533467977, 6669.633170175638, 6684.866302673968, 6703.698333574952, 6710.899336509956, 4850.320955066293, 5026.2711906773675, 5029.597632189416, 5051.26756620288, 5052.317937078521, 6779.694913728894, 6782.423494003016, 6888.242293347727, 6924.58452492852, 6934.341237582422, 5122.846314610568, 5179.093658609729, 5186.714730689849, 5190.870228244248, 5193.532582067556, 5209.7395130244095, 5220.712860792617, 5248.687828042989, 5255.658382205144, 5279.260903473517, 5772.3650398456975, 5780.884382312414, 5806.287145292149, 5811.418858114154, 5812.651240925558, 6678.165229346332, 6704.83237919056, 6720.1599800025, 6738.191417029988, 6761.0, 1810.393518171401, 1811.601447681508, 1818.0, 1819.4814477874006, 1828.5645768072, 1225.9019278457702, 1264.3488603369271, 1291.9354032298347, 1301.5965050834081, 1309.1752196116577, 6048.637081775108, 6063.120847477179, 6122.877542449126, 6165.164024548668, 6185.41238582334, 6597.274299827015, 6700.128983232246, 6716.865662686817, 6729.360710732472, 6731.528792984542, 6033.4871535919065, 6063.787767428207, 6106.511479081662, 6114.174586430864, 6151.9384806151365, 3507.5440192774777, 3520.2607452435277, 3563.518924945099, 3565.4117070683565, 3576.624454432299, 6982.301769822977, 6997.4052205562075, 7001.404880585207, 7029.578225306498, 7070.36366726997, 6853.7943861684225, 6907.827304317432, 6933.162711881356, 6951.513394062468, 6969.9303006969285, 7043.8239044023285, 7049.330313620198, 7079.752208672672, 7082.114735658043, 7094.9290507094265, 6755.2231493378895, 6760.391564759196, 6789.388954994074, 6816.522843400914, 6860.2453730088655, 6622.503312251697, 6747.493937954575, 6757.087793147862, 6776.864462710817, 6801.89797153053, 6962.582245065312, 7007.649617519001, 7020.157581090098, 7048.577085374894, 7060.7881763547175, 5103.8468845934685, 5132.692038477703, 5135.768890399866, 5163.251328557413, 5187.636865419385, 6469.353064693493, 6502.447291980235, 6781.152355955505, 6782.423494002867, 6834.692438840363, 6538.215414150332, 6546.705398256994, 6549.279579246184, 6576.8490514158875, 6593.109930159559, 6448.709808058555, 6476.481881449567, 6559.6064236145985, 6573.3098024706715, 6598.439132673777, 6381.840453988688, 6411.326810684997, 6438.3883531064475, 6448.193975753031, 6455.7740479083, 6465.806025819233, 6509.7396104155305, 6531.706073226621, 6593.241777195684, 6658.83352916181, 6381.266154392119, 6395.688883778721, 6456.225252969673, 6475.773347932988, 6539.0], "value": 5172.2254448518415, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [975.512243878061, 976.5361453309679, 1000.44975263605, 1009.8535712321718, 1011.3931641015389, 17576.0, 17724.91137544312, 17774.555636109104, 17806.643867122682, 19034.238630454784, 17872.731909021342, 18017.909910450464, 18045.187966541504, 18065.7290140648, 18091.728624070616, 1058.2169194795872, 1064.6327017179099, 1066.807974564578, 1073.9946300268527, 1074.4198133008167, 1073.5920350266927, 1074.2963358999868, 1074.3392813419769, 1076.7523469601997, 1077.805994920914, 1006.0392325329293, 1116.776644671065, 1117.9608713695022, 1122.764219513903, 1129.2546919033439, 1124.8706398764166, 1125.1561329003289, 1125.482278152051, 1125.6679279612533, 1127.143371038013, 793.317746737805, 823.625250511016, 825.640846231885, 825.8389614025267, 826.5123577089486, 18570.442886713285, 18959.62080758377, 19031.048447577567, 19108.713369299472, 19141.330053448062, 22859.88570057139, 22893.0, 23626.17308394215, 23759.406014849596, 23808.0, 18329.08354582279, 18463.907680461645, 18663.0, 18707.34524291657, 18796.530086747804, 3882.456456096149, 3923.7645741255615, 3945.4870866787132, 3948.9930067832806, 3949.605039496056, 128875.0, 160459.0, 160910.0, 162929.0, 166653.0, 14923.40306387754, 15140.470083547023, 15212.771808422882, 15230.923845380703, 15258.313375898111, 27231.455370892472, 27319.726802732115, 28305.858470707513, 28536.14391568256, 28555.143345699664, 8792.692255771017, 8961.731148065568, 8985.685501007434, 8986.640534378552, 9002.909970900208, 4344.543822898613, 4401.867943961686, 4415.116976604628, 4437.445319335083, 4438.0, 5945.613535120204, 6007.789727359522, 6063.454289114001, 6088.573799834057, 6108.5723999319625, 1244.3591550351575, 1262.2300396757971, 1269.3970364077175, 1272.401971073594, 1273.4778740716263, 728.8287252495659, 733.1312394812164, 749.7450866705346, 756.5082696247483, 760.5322726523259, 12937.417816198295, 13727.588172354845, 13769.931150344184, 14109.576712698636, 14198.787018194735, 721.9639018049077, 726.3753172271842, 728.7412968396249, 738.5605564689001, 744.8733715268309, 6303.684815759194, 6328.683565821782, 6330.240371155399, 6351.777687780906, 6353.36466353361, 144639.0, 145263.0, 145712.2714386421, 145740.0, 146233.0, 129588.3520582391, 132030.0, 132452.33773831069, 133461.0, 134973.0, 104782.47608761907, 106794.0, 107824.4608776951, 107892.46053769681, 110316.448417759, 11447.198696091195, 11663.358515281401, 11869.940650296694, 11902.345371004332, 11956.701082473008, 54961.0, 55672.16491752708, 56199.0, 56971.71514142403, 57632.0, 72071.27928720856, 72526.27473725195, 72871.63564182146, 73787.26212738019, 75291.62354188412, 17603.239676032295, 17760.0, 17950.19224134891, 18080.54798629992, 18171.727424088385, 19979.300724474575, 20047.0, 20239.79760202379, 20251.0, 20278.493037673587, 17775.46673599794, 17886.373976910745, 17894.642107157524, 18160.72758908591, 18171.727424088385, 18554.44336669902, 18711.0, 18770.343037993604, 18814.435566933014, 18971.810281897557, 17275.481735547954, 17316.82683173152, 17333.306667733654, 17511.124443778015, 17513.0, 13378.665533361744, 13405.530806421728, 13488.93255533716, 13507.39216735269, 13757.724845502833, 13818.378172982038, 13922.930385348414, 13932.233727145105, 14077.718445631235, 14083.718325633225], "value": 9790.41637537846, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1377.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 105.0, 104.0, 105.0, 108.0, 111.0, 109.0, 105.0, 105.0, 109.0], "value": 106.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 113.0, 118.0, 112.0, 110.0, 114.0, 113.0, 119.0, 117.0, 137.0], "value": 116.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 162.0, 162.0, 173.0, 162.0, 167.0, 163.0, 163.0, 167.0], "value": 164.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 73.0, 73.0, 73.0, 74.0, 73.0, 73.0, 73.0, 74.0, 73.0], "value": 73.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 79.0, 78.0, 78.0, 78.0, 78.0, 78.0, 78.0, 80.0], "value": 78.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 113.0, 114.0, 114.0, 114.0, 114.0, 113.0, 114.0, 111.0, 116.0], "value": 113.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 149.0, 149.0, 151.0, 150.0, 151.0, 151.0, 151.0, 150.0, 149.0], "value": 150.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 94.0, 94.0, 94.0, 95.0, 95.0, 95.0, 97.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [47.0, 45.0, 44.0, 45.0, 46.0, 45.0, 45.0, 44.0, 44.0, 48.0], "value": 45.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [40.0, 47.0, 40.0, 40.0, 40.0, 40.0, 40.0, 40.0, 40.0, 40.0], "value": 40.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 72.0, 70.0, 69.0, 71.0, 71.0, 69.0, 70.0, 71.0, 69.0], "value": 70.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 104.0, 104.0, 112.0, 110.0, 106.0, 109.0, 107.0, 107.0, 103.0], "value": 107.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 158.0, 155.0, 152.0, 151.0, 156.0, 150.0, 151.0, 151.0, 159.0], "value": 153.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 59.0, 60.0, 59.0, 59.0, 64.0, 65.0, 63.0, 60.0], "value": 61.0, "unit": "score"}]}]} 13:02:36 INFO - Return code: 0 13:02:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:02:36 INFO - # TBPL SUCCESS # 13:02:36 INFO - Running post-action listener: _package_coverage_data 13:02:36 INFO - Running post-action listener: _resource_record_post_action 13:02:36 INFO - [mozharness: 2017-09-26 20:02:36.653324Z] Finished run-tests step (success) 13:02:36 INFO - Running post-run listener: _resource_record_post_run 13:02:36 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 8192; Write bytes: 333099008; Read time: 164; Write time: 187312 13:02:36 INFO - TinderboxPrint: CPU usage
13.1% 13:02:36 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 164 13:02:36 INFO - TinderboxPrint: I/O write bytes / time
333,099,008 / 187,312 13:02:36 INFO - TinderboxPrint: CPU idle
8,211.7 (86.9%) 13:02:36 INFO - TinderboxPrint: CPU user
1,188.0 (12.6%) 13:02:36 INFO - TinderboxPrint: Swap in / out
0 / 0 13:02:36 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 22392832; Read time: 0; Write time: 8112 13:02:36 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 13:02:36 INFO - run-tests - Wall time: 1167s; CPU: 13.0%; Read bytes: 8192; Write bytes: 310321152; Read time: 164; Write time: 179180 13:02:37 INFO - Running post-run listener: _upload_blobber_files 13:02:37 INFO - Blob upload gear active. 13:02:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:02:37 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 13:02:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:02:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:02:37 INFO - (blobuploader) - INFO - Open directory for files ... 13:02:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 13:02:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:02:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:02:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 13:02:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:02:38 INFO - (blobuploader) - INFO - Done attempting. 13:02:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 13:02:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:02:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:02:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 13:02:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:02:39 INFO - (blobuploader) - INFO - Done attempting. 13:02:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 13:02:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:02:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:02:40 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 13:02:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:02:40 INFO - (blobuploader) - INFO - Done attempting. 13:02:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:02:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:02:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:02:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:02:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:02:44 INFO - (blobuploader) - INFO - Done attempting. 13:02:44 INFO - (blobuploader) - INFO - Iteration through files over. 13:02:44 INFO - Return code: 0 13:02:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:02:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:02:44 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eb13ab394ff1202affdadf32534d41af4883ecb7eca3dcb0645396f374cd2e95e66ca04f774740d17a8560afcdc9242620afff53e4bff85528069b0f5f064ad3", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e631722f0284eac5d32d1cf0cbc0f16bc0692f14984cec473bc2c9798d7cb760f276aa7c7d5e63b6c31889a78785f9dfbe86dd9e254549082bfa04435e532ae5", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f84517916ada2e046baec628dcdf4fb95f07d3bc57c0f89678a524e5f652108d2c435108dcb08158bfa226e23cb2eb100440dfd12d33c12d1a91282c769bba84", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/22eda638898ce5a0dab69530ead812beff2c2ea30e0958031c67e7a176a4c5f065b35d5cc7864b9c7e0fd808524408f32cb530f35d732c90364f4b6a05ed02bd"} 13:02:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:02:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:02:44 INFO - Contents: 13:02:44 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eb13ab394ff1202affdadf32534d41af4883ecb7eca3dcb0645396f374cd2e95e66ca04f774740d17a8560afcdc9242620afff53e4bff85528069b0f5f064ad3", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e631722f0284eac5d32d1cf0cbc0f16bc0692f14984cec473bc2c9798d7cb760f276aa7c7d5e63b6c31889a78785f9dfbe86dd9e254549082bfa04435e532ae5", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f84517916ada2e046baec628dcdf4fb95f07d3bc57c0f89678a524e5f652108d2c435108dcb08158bfa226e23cb2eb100440dfd12d33c12d1a91282c769bba84", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/22eda638898ce5a0dab69530ead812beff2c2ea30e0958031c67e7a176a4c5f065b35d5cc7864b9c7e0fd808524408f32cb530f35d732c90364f4b6a05ed02bd"} 13:02:44 INFO - Running post-run listener: copy_logs_to_upload_dir 13:02:44 INFO - Copying logs to upload dir... 13:02:44 INFO - mkdir: /builds/slave/test/build/upload/logs 13:02:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.934060 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2017-09-26 13:02:44.408737) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-26 13:02:44.414100) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=483e410453545d07cca6935c000001ab-1506454499.797509-1446205962 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eb13ab394ff1202affdadf32534d41af4883ecb7eca3dcb0645396f374cd2e95e66ca04f774740d17a8560afcdc9242620afff53e4bff85528069b0f5f064ad3", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e631722f0284eac5d32d1cf0cbc0f16bc0692f14984cec473bc2c9798d7cb760f276aa7c7d5e63b6c31889a78785f9dfbe86dd9e254549082bfa04435e532ae5", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f84517916ada2e046baec628dcdf4fb95f07d3bc57c0f89678a524e5f652108d2c435108dcb08158bfa226e23cb2eb100440dfd12d33c12d1a91282c769bba84", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/22eda638898ce5a0dab69530ead812beff2c2ea30e0958031c67e7a176a4c5f065b35d5cc7864b9c7e0fd808524408f32cb530f35d732c90364f4b6a05ed02bd"} build_url:https://queue.taskcluster.net/v1/task/JSqdHGsuRK2AZcN3JGZ2xg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011324 build_url: 'https://queue.taskcluster.net/v1/task/JSqdHGsuRK2AZcN3JGZ2xg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eb13ab394ff1202affdadf32534d41af4883ecb7eca3dcb0645396f374cd2e95e66ca04f774740d17a8560afcdc9242620afff53e4bff85528069b0f5f064ad3", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e631722f0284eac5d32d1cf0cbc0f16bc0692f14984cec473bc2c9798d7cb760f276aa7c7d5e63b6c31889a78785f9dfbe86dd9e254549082bfa04435e532ae5", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f84517916ada2e046baec628dcdf4fb95f07d3bc57c0f89678a524e5f652108d2c435108dcb08158bfa226e23cb2eb100440dfd12d33c12d1a91282c769bba84", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/22eda638898ce5a0dab69530ead812beff2c2ea30e0958031c67e7a176a4c5f065b35d5cc7864b9c7e0fd808524408f32cb530f35d732c90364f4b6a05ed02bd"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-26 13:02:44.443724) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 13:02:44.444158) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=483e410453545d07cca6935c000001ab-1506454499.797509-1446205962 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004508 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 13:02:44.527975) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-26 13:02:44.528374) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-26 13:02:44.528806) ========= ========= Total master_lag: 0.21 =========