builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-024 starttime: 1505369971.33 results: success (0) revision: cb717386aec8601a301babd4156aabc4cccff0b0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-13 23:19:31.325825) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-13 23:19:31.326286) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-13 23:19:31.326555) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-13 23:19:31.400931) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 23:19:31.401221) ========= 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=41a7e32711b8e08598a63237000001d6-1505362313.990101-395763722 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-13 23:19:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.7M=0s 2017-09-13 23:19:31 (46.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.078985 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 23:19:31.509716) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 23:19:31.510001) ========= 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=41a7e32711b8e08598a63237000001d6-1505362313.990101-395763722 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020234 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 23:19:31.560026) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 23:19:31.560926) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev cb717386aec8601a301babd4156aabc4cccff0b0 --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 cb717386aec8601a301babd4156aabc4cccff0b0 --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=41a7e32711b8e08598a63237000001d6-1505362313.990101-395763722 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-13 23:19:31,742 truncating revision to first 12 chars 2017-09-13 23:19:31,742 Setting DEBUG logging. 2017-09-13 23:19:31,742 attempt 1/10 2017-09-13 23:19:31,742 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/cb717386aec8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-13 23:19:32,294 unpacking tar archive at: mozilla-central-cb717386aec8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.860554 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 23:19:32.437646) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-13 23:19:32.437944) ========= script_repo_revision: cb717386aec8601a301babd4156aabc4cccff0b0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-13 23:19:32.438414) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-13 23:19:32.438684) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-13 23:19:32.451591) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2017-09-13 23:19:32.452028) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41a7e32711b8e08598a63237000001d6-1505362313.990101-395763722 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:19:32 INFO - MultiFileLogger online at 20170913 23:19:32 in /builds/slave/test 23:19:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 23:19:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:19:32 INFO - {'append_to_log': False, 23:19:32 INFO - 'base_work_dir': '/builds/slave/test', 23:19:32 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 23:19:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:19:32 INFO - 'branch': 'Firefox-Non-PGO', 23:19:32 INFO - 'buildbot_json_path': 'buildprops.json', 23:19:32 INFO - 'code_coverage': False, 23:19:32 INFO - 'config_files': ('talos/linux_config.py',), 23:19:32 INFO - 'default_actions': ('clobber', 23:19:32 INFO - 'read-buildbot-config', 23:19:32 INFO - 'download-and-extract', 23:19:32 INFO - 'populate-webroot', 23:19:32 INFO - 'create-virtualenv', 23:19:32 INFO - 'install', 23:19:32 INFO - 'setup-mitmproxy', 23:19:32 INFO - 'run-tests'), 23:19:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:19:32 INFO - 'disable_ccov_upload': False, 23:19:32 INFO - 'disable_stylo': False, 23:19:32 INFO - 'download_minidump_stackwalk': True, 23:19:32 INFO - 'download_symbols': 'ondemand', 23:19:32 INFO - 'enable_stylo': False, 23:19:32 INFO - 'enable_webrender': False, 23:19:32 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 23:19:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:19:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:19:32 INFO - 'gecko_profile': False, 23:19:32 INFO - 'gecko_profile_interval': 0, 23:19:32 INFO - 'installer_path': 'installer.exe', 23:19:32 INFO - 'log_level': 'info', 23:19:32 INFO - 'log_name': 'talos', 23:19:32 INFO - 'log_to_console': True, 23:19:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:19:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:19:32 INFO - 'opt_config_files': (), 23:19:32 INFO - 'pip_index': False, 23:19:32 INFO - 'suite': 'dromaeojs-e10s', 23:19:32 INFO - 'system_bits': '32', 23:19:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:19:32 INFO - 'title': 'talos-linux64-ix-024', 23:19:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:19:32 INFO - 'use_talos_json': True, 23:19:32 INFO - 'verify': 'False', 23:19:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:19:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:19:32 INFO - 'work_dir': 'build'} 23:19:32 INFO - [mozharness: 2017-09-14 06:19:32.776868Z] Running clobber step. 23:19:32 INFO - Running pre-action listener: _resource_record_pre_action 23:19:32 INFO - Running main action method: clobber 23:19:32 INFO - rmtree: /builds/slave/test/build 23:19:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:19:34 INFO - Running post-action listener: _resource_record_post_action 23:19:34 INFO - [mozharness: 2017-09-14 06:19:34.326310Z] Finished clobber step (success) 23:19:34 INFO - [mozharness: 2017-09-14 06:19:34.326407Z] Running read-buildbot-config step. 23:19:34 INFO - Running pre-action listener: _resource_record_pre_action 23:19:34 INFO - Running main action method: read_buildbot_config 23:19:34 INFO - Using buildbot properties: 23:19:34 INFO - { 23:19:34 INFO - "project": "", 23:19:34 INFO - "product": "firefox", 23:19:34 INFO - "who": "jdolske@mozilla.com", 23:19:34 INFO - "installer_path": "public/build/target.tar.bz2", 23:19:34 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 23:19:34 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 23:19:34 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 23:19:34 INFO - "stage_platform": "linux64", 23:19:34 INFO - "basedir": "/builds/slave/test", 23:19:34 INFO - "buildnumber": 1146, 23:19:34 INFO - "platform": "ubuntu64_hw", 23:19:34 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 23:19:34 INFO - "slavebuilddir": "test", 23:19:34 INFO - "taskId": "R_35QaooQYG3DH03IK0upw", 23:19:34 INFO - "branch": "mozilla-central", 23:19:34 INFO - "script_repo_revision": "production", 23:19:34 INFO - "revision": "cb717386aec8601a301babd4156aabc4cccff0b0", 23:19:34 INFO - "slavename": "talos-linux64-ix-024", 23:19:34 INFO - "repo_path": "mozilla-central" 23:19:34 INFO - } 23:19:34 INFO - Finding installer, test and symbols from parent task. 23:19:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/R_35QaooQYG3DH03IK0upw'}, attempt #1 23:19:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/R_35QaooQYG3DH03IK0upw'}, attempt #1 23:19:35 INFO - Task dependencies: Zv5HYUSPS56G-8wZXuIJvw 23:19:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Zv5HYUSPS56G-8wZXuIJvw'}, attempt #1 23:19:35 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Zv5HYUSPS56G-8wZXuIJvw/artifacts/public/build/target.tar.bz2 23:19:35 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/Zv5HYUSPS56G-8wZXuIJvw/artifacts/public/build/target.test_packages.json 23:19:35 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Zv5HYUSPS56G-8wZXuIJvw/artifacts/public/build/target.crashreporter-symbols.zip 23:19:35 INFO - Running post-action listener: _resource_record_post_action 23:19:35 INFO - [mozharness: 2017-09-14 06:19:35.746842Z] Finished read-buildbot-config step (success) 23:19:35 INFO - [mozharness: 2017-09-14 06:19:35.747060Z] Running download-and-extract step. 23:19:35 INFO - Running pre-action listener: _resource_record_pre_action 23:19:35 INFO - Running main action method: download_and_extract 23:19:35 INFO - mkdir: /builds/slave/test/build/tests 23:19:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:19:35 INFO - trying https://queue.taskcluster.net/v1/task/Zv5HYUSPS56G-8wZXuIJvw/artifacts/public/build/target.test_packages.json 23:19:35 INFO - Downloading https://queue.taskcluster.net/v1/task/Zv5HYUSPS56G-8wZXuIJvw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 23:19:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Zv5HYUSPS56G-8wZXuIJvw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 23:19:36 INFO - Downloaded 989 bytes. 23:19:36 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 23:19:36 INFO - Using the following test package requirements: 23:19:36 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 23:19:36 INFO - u'common': [u'target.common.tests.zip'], 23:19:36 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 23:19:36 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 23:19:36 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 23:19:36 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 23:19:36 INFO - u'mozbase': [u'target.common.tests.zip'], 23:19:36 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 23:19:36 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 23:19:36 INFO - u'web-platform': [u'target.common.tests.zip', 23:19:36 INFO - u'target.web-platform.tests.tar.gz'], 23:19:36 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 23:19:36 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 23:19:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Zv5HYUSPS56G-8wZXuIJvw/artifacts/public/build/target.common.tests.zip 23:19:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Zv5HYUSPS56G-8wZXuIJvw/artifacts/public/build/target.common.tests.zip'}, attempt #1 23:19:36 INFO - Fetch https://queue.taskcluster.net/v1/task/Zv5HYUSPS56G-8wZXuIJvw/artifacts/public/build/target.common.tests.zip into memory 23:19:38 INFO - Content-Length response header: 54572613 23:19:38 INFO - Bytes received: 54572613 23:19:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Zv5HYUSPS56G-8wZXuIJvw/artifacts/public/build/target.talos.tests.zip 23:19:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Zv5HYUSPS56G-8wZXuIJvw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 23:19:48 INFO - Fetch https://queue.taskcluster.net/v1/task/Zv5HYUSPS56G-8wZXuIJvw/artifacts/public/build/target.talos.tests.zip into memory 23:19:49 INFO - Content-Length response header: 14500356 23:19:49 INFO - Bytes received: 14500356 23:19: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')]} 23:19:50 INFO - trying https://queue.taskcluster.net/v1/task/Zv5HYUSPS56G-8wZXuIJvw/artifacts/public/build/target.tar.bz2 23:19:50 INFO - Downloading https://queue.taskcluster.net/v1/task/Zv5HYUSPS56G-8wZXuIJvw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 23:19:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Zv5HYUSPS56G-8wZXuIJvw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 23:19:51 INFO - Downloaded 61337791 bytes. 23:19:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Zv5HYUSPS56G-8wZXuIJvw/artifacts/public/build/target.tar.bz2 23:19:52 INFO - mkdir: /builds/slave/test/properties 23:19:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:19:52 INFO - Writing to file /builds/slave/test/properties/build_url 23:19:52 INFO - Contents: 23:19:52 INFO - build_url:https://queue.taskcluster.net/v1/task/Zv5HYUSPS56G-8wZXuIJvw/artifacts/public/build/target.tar.bz2 23:19:52 INFO - Running post-action listener: _resource_record_post_action 23:19:52 INFO - Running post-action listener: find_tests_for_verification 23:19:52 INFO - Running post-action listener: set_extra_try_arguments 23:19:52 INFO - [mozharness: 2017-09-14 06:19:52.323001Z] Finished download-and-extract step (success) 23:19:52 INFO - [mozharness: 2017-09-14 06:19:52.323485Z] Running populate-webroot step. 23:19:52 INFO - Running pre-action listener: _resource_record_pre_action 23:19:52 INFO - Running main action method: populate_webroot 23:19:52 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:19:52 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 23:19:52 INFO - 'tests': ['tresize', 23:19:52 INFO - 'tcanvasmark']}, 23:19:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:19:52 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 23:19:52 INFO - 'tests': ['dromaeo_css', 23:19:52 INFO - 'kraken']}, 23:19:52 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 23:19:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:19:52 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 23:19:52 INFO - 'talos_options': ['--disable-stylo'], 23:19:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:19:52 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 23:19:52 INFO - 'tests': ['damp', 'tps']}, 23:19:52 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 23:19:52 INFO - 'talos_options': ['--disable-stylo'], 23:19:52 INFO - 'tests': ['damp', 'tps']}, 23:19:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:19:52 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 23:19:52 INFO - 'tests': ['dromaeo_dom']}, 23:19:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 23:19:52 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 23:19:52 INFO - 'tests': ['basic_compositor_video', 23:19:52 INFO - 'glvideo']}, 23:19:52 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 23:19:52 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 23:19:52 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 23:19:52 INFO - 'talos_options': ['--disable-stylo'], 23:19:52 INFO - 'tests': ['ts_paint_webext', 23:19:52 INFO - 'tp5o_webext']}, 23:19:52 INFO - 'other-e10s': {'tests': ['a11yr', 23:19:52 INFO - 'ts_paint', 23:19:52 INFO - 'tpaint', 23:19:52 INFO - 'sessionrestore', 23:19:52 INFO - 'sessionrestore_many_windows', 23:19:52 INFO - 'sessionrestore_no_auto_restore', 23:19:52 INFO - 'tabpaint']}, 23:19:52 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 23:19:52 INFO - 'tests': ['a11yr', 23:19:52 INFO - 'ts_paint', 23:19:52 INFO - 'tpaint', 23:19:52 INFO - 'sessionrestore', 23:19:52 INFO - 'sessionrestore_many_windows', 23:19:52 INFO - 'sessionrestore_no_auto_restore', 23:19:52 INFO - 'tabpaint']}, 23:19:52 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 23:19:52 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 23:19:52 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 23:19:52 INFO - 'tests': ['bloom_basic_singleton']}, 23:19:52 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 23:19:52 INFO - 'tests': ['bloom_basic']}, 23:19:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:19:52 INFO - 'tsvgr_opacity', 23:19:52 INFO - 'tart', 23:19:52 INFO - 'tscrollx', 23:19:52 INFO - 'tsvg_static']}, 23:19:52 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 23:19:52 INFO - 'tests': ['tsvgx', 23:19:52 INFO - 'tsvgr_opacity', 23:19:52 INFO - 'tart', 23:19:52 INFO - 'tscrollx', 23:19:52 INFO - 'tsvg_static']}, 23:19:52 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 23:19:52 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 23:19:52 INFO - 'talos_options': ['--disable-stylo'], 23:19:52 INFO - 'tests': ['tp5o']}, 23:19:52 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 23:19:52 INFO - 'talos_options': ['--mitmproxy', 23:19:52 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 23:19:52 INFO - '--firstNonBlankPaint'], 23:19:52 INFO - 'tests': ['tp6_google', 23:19:52 INFO - 'tp6_youtube', 23:19:52 INFO - 'tp6_amazon', 23:19:52 INFO - 'tp6_facebook']}, 23:19:52 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 23:19:52 INFO - 'talos_options': ['--disable-stylo', 23:19:52 INFO - '--mitmproxy', 23:19:52 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 23:19:52 INFO - '--firstNonBlankPaint'], 23:19:52 INFO - 'tests': ['tp6_google', 23:19:52 INFO - 'tp6_youtube', 23:19:52 INFO - 'tp6_amazon', 23:19:52 INFO - 'tp6_facebook']}, 23:19:52 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 23:19:52 INFO - 'talos_options': ['--stylo-threads=1', 23:19:52 INFO - '--mitmproxy', 23:19:52 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 23:19:52 INFO - '--firstNonBlankPaint'], 23:19:52 INFO - 'tests': ['tp6_google', 23:19:52 INFO - 'tp6_youtube', 23:19:52 INFO - 'tp6_amazon', 23:19:52 INFO - 'tp6_facebook']}, 23:19:52 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 23:19:52 INFO - 'talos_options': ['--xperf_path', 23:19:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:19:52 INFO - 'tests': ['tp5n']}, 23:19:52 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 23:19:52 INFO - 'talos_options': ['--disable-stylo', 23:19:52 INFO - '--xperf_path', 23:19:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:19:52 INFO - 'tests': ['tp5n']}}} 23:19:52 INFO - Running post-action listener: _resource_record_post_action 23:19:52 INFO - [mozharness: 2017-09-14 06:19:52.346532Z] Finished populate-webroot step (success) 23:19:52 INFO - [mozharness: 2017-09-14 06:19:52.346625Z] Running create-virtualenv step. 23:19:52 INFO - Running pre-action listener: _resource_record_pre_action 23:19:52 INFO - Running main action method: create_virtualenv 23:19:52 INFO - Creating virtualenv /builds/slave/test/build/venv 23:19:52 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 23:19:52 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 23:19:52 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 23:19:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:19:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:19:52 INFO - Installing distribute.............................................................................................................................................................................................done. 23:19:53 INFO - Installing pip...............done. 23:19:53 INFO - Return code: 0 23:19:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 23:19:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 23:19:53 INFO - Reading from file tmpfile_stdout 23:19:53 INFO - Output received: 23:19:53 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 23:19:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:19:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:19:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:19:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:19:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:19:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c561f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc6090>, '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 0x1fc6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fc0f90>, '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': '41a7e32711b8e08598a63237000001d6-1505362313.990101-395763722', '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 23:19:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 23:19:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 23:19:53 INFO - Using env: {'DISPLAY': ':0', 23:19:53 INFO - 'HOME': '/home/cltbld', 23:19:53 INFO - 'LANG': 'en_US.UTF-8', 23:19:53 INFO - 'LANGUAGE': 'en_US:en', 23:19:53 INFO - 'LOGNAME': 'cltbld', 23:19:53 INFO - 'MAIL': '/var/mail/cltbld', 23:19:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:19:53 INFO - 'MOZ_NO_REMOTE': '1', 23:19:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:19:53 INFO - 'NO_EM_RESTART': '1', 23:19:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:19:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:19:53 INFO - 'PWD': '/builds/slave/test', 23:19:53 INFO - 'SHELL': '/bin/bash', 23:19:53 INFO - 'SHLVL': '1', 23:19:53 INFO - 'TERM': 'linux', 23:19:53 INFO - 'TMOUT': '86400', 23:19:53 INFO - 'USER': 'cltbld', 23:19:53 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1505362313.990101-395763722', 23:19:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:19:53 INFO - '_': '/tools/buildbot/bin/python'} 23:19:54 INFO - Ignoring indexes: http://pypi.python.org/simple/ 23:19:54 INFO - Downloading/unpacking pip>=1.5 23:19:54 INFO - Running setup.py egg_info for package pip 23:19:54 INFO - warning: no files found matching 'pip/cacert.pem' 23:19:54 INFO - warning: no files found matching '*.html' under directory 'docs' 23:19:54 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 23:19:54 INFO - no previously-included directories found matching 'docs/_build/_sources' 23:19:54 INFO - Installing collected packages: pip 23:19:54 INFO - Found existing installation: pip 1.1 23:19:54 INFO - Uninstalling pip: 23:19:54 INFO - Successfully uninstalled pip 23:19:54 INFO - Running setup.py install for pip 23:19:54 INFO - warning: no files found matching 'pip/cacert.pem' 23:19:54 INFO - warning: no files found matching '*.html' under directory 'docs' 23:19:54 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 23:19:54 INFO - no previously-included directories found matching 'docs/_build/_sources' 23:19:54 INFO - Installing pip script to /builds/slave/test/build/venv/bin 23:19:54 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 23:19:54 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 23:19:54 INFO - Successfully installed pip 23:19:54 INFO - Cleaning up... 23:19:54 INFO - Return code: 0 23:19:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:19:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:19:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:19:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:19:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:19:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c561f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc6090>, '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 0x1fc6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fc0f90>, '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': '41a7e32711b8e08598a63237000001d6-1505362313.990101-395763722', '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 23:19:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 23:19:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 23:19:54 INFO - Using env: {'DISPLAY': ':0', 23:19:54 INFO - 'HOME': '/home/cltbld', 23:19:54 INFO - 'LANG': 'en_US.UTF-8', 23:19:54 INFO - 'LANGUAGE': 'en_US:en', 23:19:54 INFO - 'LOGNAME': 'cltbld', 23:19:54 INFO - 'MAIL': '/var/mail/cltbld', 23:19:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:19:54 INFO - 'MOZ_NO_REMOTE': '1', 23:19:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:19:54 INFO - 'NO_EM_RESTART': '1', 23:19:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:19:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:19:54 INFO - 'PWD': '/builds/slave/test', 23:19:54 INFO - 'SHELL': '/bin/bash', 23:19:54 INFO - 'SHLVL': '1', 23:19:54 INFO - 'TERM': 'linux', 23:19:54 INFO - 'TMOUT': '86400', 23:19:54 INFO - 'USER': 'cltbld', 23:19:54 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1505362313.990101-395763722', 23:19:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:19:54 INFO - '_': '/tools/buildbot/bin/python'} 23:19:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:19:54 INFO - Downloading/unpacking psutil>=3.1.1 23:19:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:19:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:19:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:19:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:19:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:19:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:19:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:19:59 INFO - Installing collected packages: psutil 23:19:59 INFO - Running setup.py install for psutil 23:19:59 INFO - building 'psutil._psutil_linux' extension 23:19:59 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 23:19:59 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 23:19:59 INFO - building 'psutil._psutil_posix' extension 23:19:59 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 23:19:59 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 23:19:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:19:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:19:59 INFO - Successfully installed psutil 23:19:59 INFO - Cleaning up... 23:20:00 INFO - Return code: 0 23:20:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:20:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:20:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:20:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:20:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:20:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c561f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc6090>, '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 0x1fc6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fc0f90>, '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': '41a7e32711b8e08598a63237000001d6-1505362313.990101-395763722', '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 23:20:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 23:20:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 23:20:00 INFO - Using env: {'DISPLAY': ':0', 23:20:00 INFO - 'HOME': '/home/cltbld', 23:20:00 INFO - 'LANG': 'en_US.UTF-8', 23:20:00 INFO - 'LANGUAGE': 'en_US:en', 23:20:00 INFO - 'LOGNAME': 'cltbld', 23:20:00 INFO - 'MAIL': '/var/mail/cltbld', 23:20:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:20:00 INFO - 'MOZ_NO_REMOTE': '1', 23:20:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:20:00 INFO - 'NO_EM_RESTART': '1', 23:20:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:20:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:20:00 INFO - 'PWD': '/builds/slave/test', 23:20:00 INFO - 'SHELL': '/bin/bash', 23:20:00 INFO - 'SHLVL': '1', 23:20:00 INFO - 'TERM': 'linux', 23:20:00 INFO - 'TMOUT': '86400', 23:20:00 INFO - 'USER': 'cltbld', 23:20:00 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1505362313.990101-395763722', 23:20:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:20:00 INFO - '_': '/tools/buildbot/bin/python'} 23:20:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:20:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:20:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:20:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:20:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:20:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:20:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:20:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:20:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:20:01 INFO - Installing collected packages: mozsystemmonitor 23:20:01 INFO - Running setup.py install for mozsystemmonitor 23:20:01 INFO - Successfully installed mozsystemmonitor 23:20:01 INFO - Cleaning up... 23:20:01 INFO - Return code: 0 23:20:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:20:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:20:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:20:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:20:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:20:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1c561f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc6090>, '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 0x1fc6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fc0f90>, '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': '41a7e32711b8e08598a63237000001d6-1505362313.990101-395763722', '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 23:20:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 23:20:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 23:20:01 INFO - Using env: {'DISPLAY': ':0', 23:20:01 INFO - 'HOME': '/home/cltbld', 23:20:01 INFO - 'LANG': 'en_US.UTF-8', 23:20:01 INFO - 'LANGUAGE': 'en_US:en', 23:20:01 INFO - 'LOGNAME': 'cltbld', 23:20:01 INFO - 'MAIL': '/var/mail/cltbld', 23:20:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:20:01 INFO - 'MOZ_NO_REMOTE': '1', 23:20:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:20:01 INFO - 'NO_EM_RESTART': '1', 23:20:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:20:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:20:01 INFO - 'PWD': '/builds/slave/test', 23:20:01 INFO - 'SHELL': '/bin/bash', 23:20:01 INFO - 'SHLVL': '1', 23:20:01 INFO - 'TERM': 'linux', 23:20:01 INFO - 'TMOUT': '86400', 23:20:01 INFO - 'USER': 'cltbld', 23:20:01 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1505362313.990101-395763722', 23:20:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:20:01 INFO - '_': '/tools/buildbot/bin/python'} 23:20:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:20:01 INFO - Downloading/unpacking jsonschema==2.5.1 23:20:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:20:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:20:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:20:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:20:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:20:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:20:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:20:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:20:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:20:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:20:03 INFO - Downloading functools32-3.2.3-2.tar.gz 23:20:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:20:03 INFO - warning: no files found matching '*.txt' 23:20:03 INFO - no previously-included directories found matching 'build' 23:20:03 INFO - no previously-included directories found matching 'dist' 23:20:03 INFO - no previously-included directories found matching '.git*' 23:20:03 INFO - Installing collected packages: jsonschema, functools32 23:20:03 INFO - Running setup.py install for functools32 23:20:03 INFO - warning: no files found matching '*.txt' 23:20:03 INFO - no previously-included directories found matching 'build' 23:20:03 INFO - no previously-included directories found matching 'dist' 23:20:03 INFO - no previously-included directories found matching '.git*' 23:20:03 INFO - Successfully installed jsonschema functools32 23:20:03 INFO - Cleaning up... 23:20:03 INFO - Return code: 0 23:20:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 23:20:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:20:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:20:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:20:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:20:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c561f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc6090>, '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 0x1fc6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fc0f90>, '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': '41a7e32711b8e08598a63237000001d6-1505362313.990101-395763722', '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 23:20:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 23:20:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 23:20:03 INFO - Using env: {'DISPLAY': ':0', 23:20:03 INFO - 'HOME': '/home/cltbld', 23:20:03 INFO - 'LANG': 'en_US.UTF-8', 23:20:03 INFO - 'LANGUAGE': 'en_US:en', 23:20:03 INFO - 'LOGNAME': 'cltbld', 23:20:03 INFO - 'MAIL': '/var/mail/cltbld', 23:20:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:20:03 INFO - 'MOZ_NO_REMOTE': '1', 23:20:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:20:03 INFO - 'NO_EM_RESTART': '1', 23:20:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:20:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:20:03 INFO - 'PWD': '/builds/slave/test', 23:20:03 INFO - 'SHELL': '/bin/bash', 23:20:03 INFO - 'SHLVL': '1', 23:20:03 INFO - 'TERM': 'linux', 23:20:03 INFO - 'TMOUT': '86400', 23:20:03 INFO - 'USER': 'cltbld', 23:20:03 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1505362313.990101-395763722', 23:20:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:20:03 INFO - '_': '/tools/buildbot/bin/python'} 23:20:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:20:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 23:20:03 INFO - Cleaning up... 23:20:03 INFO - Return code: 0 23:20:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:20:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:20:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:20:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:20:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:20:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c561f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc6090>, '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 0x1fc6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fc0f90>, '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': '41a7e32711b8e08598a63237000001d6-1505362313.990101-395763722', '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 23:20:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 23:20:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 23:20:03 INFO - Using env: {'DISPLAY': ':0', 23:20:03 INFO - 'HOME': '/home/cltbld', 23:20:03 INFO - 'LANG': 'en_US.UTF-8', 23:20:03 INFO - 'LANGUAGE': 'en_US:en', 23:20:03 INFO - 'LOGNAME': 'cltbld', 23:20:03 INFO - 'MAIL': '/var/mail/cltbld', 23:20:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:20:03 INFO - 'MOZ_NO_REMOTE': '1', 23:20:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:20:03 INFO - 'NO_EM_RESTART': '1', 23:20:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:20:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:20:03 INFO - 'PWD': '/builds/slave/test', 23:20:03 INFO - 'SHELL': '/bin/bash', 23:20:03 INFO - 'SHLVL': '1', 23:20:03 INFO - 'TERM': 'linux', 23:20:03 INFO - 'TMOUT': '86400', 23:20:03 INFO - 'USER': 'cltbld', 23:20:03 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1505362313.990101-395763722', 23:20:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:20:03 INFO - '_': '/tools/buildbot/bin/python'} 23:20:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:20:03 INFO - Downloading/unpacking blobuploader==1.2.4 23:20:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:20:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:20:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:20:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:20:04 INFO - Downloading blobuploader-1.2.4.tar.gz 23:20:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:20:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:20:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:20:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:20:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:20:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:20:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:20:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:20:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:20:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:20:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:20:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:20:05 INFO - Downloading docopt-0.6.1.tar.gz 23:20:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:20:05 INFO - Installing collected packages: blobuploader, requests, docopt 23:20:05 INFO - Running setup.py install for blobuploader 23:20:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:20:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:20:05 INFO - Running setup.py install for requests 23:20:05 INFO - Running setup.py install for docopt 23:20:06 INFO - Successfully installed blobuploader requests docopt 23:20:06 INFO - Cleaning up... 23:20:06 INFO - Return code: 0 23:20:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:20:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:20:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:20:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:20:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:20:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c561f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc6090>, '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 0x1fc6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fc0f90>, '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': '41a7e32711b8e08598a63237000001d6-1505362313.990101-395763722', '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 23:20:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 23:20:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:20:06 INFO - Using env: {'DISPLAY': ':0', 23:20:06 INFO - 'HOME': '/home/cltbld', 23:20:06 INFO - 'LANG': 'en_US.UTF-8', 23:20:06 INFO - 'LANGUAGE': 'en_US:en', 23:20:06 INFO - 'LOGNAME': 'cltbld', 23:20:06 INFO - 'MAIL': '/var/mail/cltbld', 23:20:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:20:06 INFO - 'MOZ_NO_REMOTE': '1', 23:20:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:20:06 INFO - 'NO_EM_RESTART': '1', 23:20:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:20:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:20:06 INFO - 'PWD': '/builds/slave/test', 23:20:06 INFO - 'SHELL': '/bin/bash', 23:20:06 INFO - 'SHLVL': '1', 23:20:06 INFO - 'TERM': 'linux', 23:20:06 INFO - 'TMOUT': '86400', 23:20:06 INFO - 'USER': 'cltbld', 23:20:06 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1505362313.990101-395763722', 23:20:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:20:06 INFO - '_': '/tools/buildbot/bin/python'} 23:20:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:20:06 INFO - Running setup.py (path:/tmp/pip-SDYnjJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:20:06 INFO - Running setup.py (path:/tmp/pip-LAAHu3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:20:06 INFO - Running setup.py (path:/tmp/pip-nSApO4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:20:06 INFO - Running setup.py (path:/tmp/pip-Zsuup3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:20:06 INFO - Running setup.py (path:/tmp/pip-sakRoW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:20:06 INFO - Running setup.py (path:/tmp/pip-lfedWU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:20:06 INFO - Running setup.py (path:/tmp/pip-YJj8pw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:20:06 INFO - Running setup.py (path:/tmp/pip-Q7uiVQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:20:06 INFO - Running setup.py (path:/tmp/pip-VvjiZ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:20:06 INFO - Running setup.py (path:/tmp/pip-ugOSGC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:20:07 INFO - Running setup.py (path:/tmp/pip-1G2ClT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:20:07 INFO - Running setup.py (path:/tmp/pip-b6M9gq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:20:07 INFO - Running setup.py (path:/tmp/pip-gGQbon-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:20:07 INFO - Running setup.py (path:/tmp/pip-HEZYmk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:20:07 INFO - Running setup.py (path:/tmp/pip-0O_RZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:20:07 INFO - Running setup.py (path:/tmp/pip-Y0Rtdc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:20:07 INFO - Running setup.py (path:/tmp/pip-zWVCVH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:20:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:20:07 INFO - Running setup.py install for manifestparser 23:20:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:20:07 INFO - Running setup.py install for mozcrash 23:20:07 INFO - Running setup.py install for mozdebug 23:20:07 INFO - Running setup.py install for mozdevice 23:20:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:20:07 INFO - Running setup.py install for mozfile 23:20:08 INFO - Running setup.py install for mozhttpd 23:20:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:20:08 INFO - Running setup.py install for mozinfo 23:20:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:20:08 INFO - Running setup.py install for mozInstall 23:20:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:20:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:20:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:20:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:20:08 INFO - Running setup.py install for mozleak 23:20:08 INFO - Running setup.py install for mozlog 23:20:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:20:08 INFO - Running setup.py install for moznetwork 23:20:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:20:08 INFO - Running setup.py install for mozprocess 23:20:08 INFO - Running setup.py install for mozprofile 23:20:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:20:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:20:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:20:08 INFO - Running setup.py install for mozrunner 23:20:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:20:08 INFO - Running setup.py install for mozscreenshot 23:20:09 INFO - Running setup.py install for moztest 23:20:09 INFO - Running setup.py install for mozversion 23:20:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:20:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:20:09 INFO - Cleaning up... 23:20:09 INFO - Return code: 0 23:20:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:20: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')]} 23:20:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:20: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')]} 23:20:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:20:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c561f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc6090>, '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 0x1fc6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fc0f90>, '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': '41a7e32711b8e08598a63237000001d6-1505362313.990101-395763722', '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 23:20:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 23:20:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:20:09 INFO - Using env: {'DISPLAY': ':0', 23:20:09 INFO - 'HOME': '/home/cltbld', 23:20:09 INFO - 'LANG': 'en_US.UTF-8', 23:20:09 INFO - 'LANGUAGE': 'en_US:en', 23:20:09 INFO - 'LOGNAME': 'cltbld', 23:20:09 INFO - 'MAIL': '/var/mail/cltbld', 23:20:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:20:09 INFO - 'MOZ_NO_REMOTE': '1', 23:20:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:20:09 INFO - 'NO_EM_RESTART': '1', 23:20:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:20:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:20:09 INFO - 'PWD': '/builds/slave/test', 23:20:09 INFO - 'SHELL': '/bin/bash', 23:20:09 INFO - 'SHLVL': '1', 23:20:09 INFO - 'TERM': 'linux', 23:20:09 INFO - 'TMOUT': '86400', 23:20:09 INFO - 'USER': 'cltbld', 23:20:09 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1505362313.990101-395763722', 23:20:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:20:09 INFO - '_': '/tools/buildbot/bin/python'} 23:20:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:20:09 INFO - Running setup.py (path:/tmp/pip-QQhspU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:20:09 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 23:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:20:09 INFO - Running setup.py (path:/tmp/pip-DFKil1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:20:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:20:09 INFO - Running setup.py (path:/tmp/pip-cAzRII-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:20:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 23:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:20:09 INFO - Running setup.py (path:/tmp/pip-R0Oqid-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:20:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:20:09 INFO - Running setup.py (path:/tmp/pip-Z6KjE8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:20:09 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)) 23:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:20:09 INFO - Running setup.py (path:/tmp/pip-qSgjdH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:20:09 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)) 23:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:20:09 INFO - Running setup.py (path:/tmp/pip-lo6oma-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:20:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 23:20:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:20:10 INFO - Running setup.py (path:/tmp/pip-7x957P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:20:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 23:20:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:20:10 INFO - Running setup.py (path:/tmp/pip-8WpU9x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:20:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 23:20:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:20:10 INFO - Running setup.py (path:/tmp/pip-gxadL_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:20:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:20:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:20:10 INFO - Running setup.py (path:/tmp/pip-RCe3xO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:20:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 23:20:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:20:10 INFO - Running setup.py (path:/tmp/pip-E7Wal1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:20:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 23:20:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:20:10 INFO - Running setup.py (path:/tmp/pip-_nWHi1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:20:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 23:20:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:20:10 INFO - Running setup.py (path:/tmp/pip-jIh3BO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:20:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 23:20:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:20:10 INFO - Running setup.py (path:/tmp/pip-bvA7jY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:20:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 23:20:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:20:10 INFO - Running setup.py (path:/tmp/pip-HU_dmP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:20:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 23:20:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:20:10 INFO - Running setup.py (path:/tmp/pip-pEXBwm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:20:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 23:20:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:20:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:20:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 23:20:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:20:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:20:10 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 23:20:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:20:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:20:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:20:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:20:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:20:11 INFO - Downloading blessings-1.6.tar.gz 23:20:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:20:11 INFO - Installing collected packages: blessings 23:20:11 INFO - Running setup.py install for blessings 23:20:12 INFO - Successfully installed blessings 23:20:12 INFO - Cleaning up... 23:20:12 INFO - Return code: 0 23:20:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:20:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:20:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:20:12 INFO - Reading from file tmpfile_stdout 23:20:12 INFO - Current package versions: 23:20:12 INFO - argparse == 1.2.1 23:20:12 INFO - blessings == 1.6 23:20:12 INFO - blobuploader == 1.2.4 23:20:12 INFO - docopt == 0.6.1 23:20:12 INFO - functools32 == 3.2.3-2 23:20:12 INFO - jsonschema == 2.5.1 23:20:12 INFO - manifestparser == 1.1 23:20:12 INFO - mozInstall == 1.13 23:20:12 INFO - mozcrash == 1.0 23:20:12 INFO - mozdebug == 0.1 23:20:12 INFO - mozdevice == 0.51 23:20:12 INFO - mozfile == 1.2 23:20:12 INFO - mozhttpd == 0.7 23:20:12 INFO - mozinfo == 0.10 23:20:12 INFO - mozleak == 0.1 23:20:12 INFO - mozlog == 3.5 23:20:12 INFO - moznetwork == 0.27 23:20:12 INFO - mozprocess == 0.25 23:20:12 INFO - mozprofile == 0.28 23:20:12 INFO - mozrunner == 6.13 23:20:12 INFO - mozscreenshot == 0.1 23:20:12 INFO - mozsystemmonitor == 0.3 23:20:12 INFO - moztest == 0.8 23:20:12 INFO - mozversion == 1.4 23:20:12 INFO - psutil == 3.1.1 23:20:12 INFO - requests == 1.2.3 23:20:12 INFO - wsgiref == 0.1.2 23:20:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:20:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:20:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:20:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:20:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:20:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c561f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc6090>, '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 0x1fc6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fc0f90>, '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': '41a7e32711b8e08598a63237000001d6-1505362313.990101-395763722', '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 23:20:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 23:20:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:20:12 INFO - Using env: {'DISPLAY': ':0', 23:20:12 INFO - 'HOME': '/home/cltbld', 23:20:12 INFO - 'LANG': 'en_US.UTF-8', 23:20:12 INFO - 'LANGUAGE': 'en_US:en', 23:20:12 INFO - 'LOGNAME': 'cltbld', 23:20:12 INFO - 'MAIL': '/var/mail/cltbld', 23:20:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:20:12 INFO - 'MOZ_NO_REMOTE': '1', 23:20:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:20:12 INFO - 'NO_EM_RESTART': '1', 23:20:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:20:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:20:12 INFO - 'PWD': '/builds/slave/test', 23:20:12 INFO - 'SHELL': '/bin/bash', 23:20:12 INFO - 'SHLVL': '1', 23:20:12 INFO - 'TERM': 'linux', 23:20:12 INFO - 'TMOUT': '86400', 23:20:12 INFO - 'USER': 'cltbld', 23:20:12 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1505362313.990101-395763722', 23:20:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:20:12 INFO - '_': '/tools/buildbot/bin/python'} 23:20:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:20:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 23:20:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 23:20:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 23:20:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 23:20:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 23:20:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 23:20:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 23:20:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 23:20:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 23:20:12 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 23:20:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:20:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:20:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:20:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:20:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 23:20:13 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 23:20:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 23:20:13 INFO - Installing collected packages: simplejson 23:20:13 INFO - Running setup.py install for simplejson 23:20:13 INFO - building 'simplejson._speedups' extension 23:20:13 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 23:20:14 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 23:20:14 INFO - Successfully installed simplejson 23:20:14 INFO - Cleaning up... 23:20:14 INFO - Return code: 0 23:20:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:20:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:20:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:20:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:20:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:20:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c561f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc6090>, '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 0x1fc6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fc0f90>, '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': '41a7e32711b8e08598a63237000001d6-1505362313.990101-395763722', '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 23:20:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 23:20:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 23:20:14 INFO - Using env: {'DISPLAY': ':0', 23:20:14 INFO - 'HOME': '/home/cltbld', 23:20:14 INFO - 'LANG': 'en_US.UTF-8', 23:20:14 INFO - 'LANGUAGE': 'en_US:en', 23:20:14 INFO - 'LOGNAME': 'cltbld', 23:20:14 INFO - 'MAIL': '/var/mail/cltbld', 23:20:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:20:14 INFO - 'MOZ_NO_REMOTE': '1', 23:20:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:20:14 INFO - 'NO_EM_RESTART': '1', 23:20:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:20:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:20:14 INFO - 'PWD': '/builds/slave/test', 23:20:14 INFO - 'SHELL': '/bin/bash', 23:20:14 INFO - 'SHLVL': '1', 23:20:14 INFO - 'TERM': 'linux', 23:20:14 INFO - 'TMOUT': '86400', 23:20:14 INFO - 'USER': 'cltbld', 23:20:14 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1505362313.990101-395763722', 23:20:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:20:14 INFO - '_': '/tools/buildbot/bin/python'} 23:20:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:20:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:20:15 INFO - Cleaning up... 23:20:15 INFO - Return code: 0 23:20:15 INFO - Running post-action listener: _resource_record_post_action 23:20:15 INFO - Running post-action listener: _start_resource_monitoring 23:20:15 INFO - Starting resource monitoring. 23:20:15 INFO - [mozharness: 2017-09-14 06:20:15.185025Z] Finished create-virtualenv step (success) 23:20:15 INFO - [mozharness: 2017-09-14 06:20:15.185497Z] Running install step. 23:20:15 INFO - Running pre-action listener: _resource_record_pre_action 23:20:15 INFO - Running main action method: install 23:20:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:20:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:20:15 INFO - Reading from file tmpfile_stdout 23:20:15 INFO - Detecting whether we're running mozinstall >=1.0... 23:20:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:20:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:20:15 INFO - Reading from file tmpfile_stdout 23:20:15 INFO - Output received: 23:20:15 INFO - Usage: mozinstall [options] installer 23:20:15 INFO - Options: 23:20:15 INFO - -h, --help show this help message and exit 23:20:15 INFO - -d DEST, --destination=DEST 23:20:15 INFO - Directory to install application into. [default: 23:20:15 INFO - "/builds/slave/test"] 23:20:15 INFO - --app=APP Application being installed. [default: firefox] 23:20:15 INFO - mkdir: /builds/slave/test/build/application 23:20:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 23:20:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 23:20:33 INFO - Reading from file tmpfile_stdout 23:20:33 INFO - Output received: 23:20:33 INFO - /builds/slave/test/build/application/firefox/firefox 23:20:33 INFO - Running post-action listener: _resource_record_post_action 23:20:33 INFO - [mozharness: 2017-09-14 06:20:33.221601Z] Finished install step (success) 23:20:33 INFO - [mozharness: 2017-09-14 06:20:33.221935Z] Running setup-mitmproxy step. 23:20:33 INFO - Running pre-action listener: _resource_record_pre_action 23:20:33 INFO - Running main action method: setup_mitmproxy 23:20:33 INFO - Skipping: mitmproxy is not required 23:20:33 INFO - Running post-action listener: _resource_record_post_action 23:20:33 INFO - [mozharness: 2017-09-14 06:20:33.223594Z] Finished setup-mitmproxy step (success) 23:20:33 INFO - [mozharness: 2017-09-14 06:20:33.223906Z] Running run-tests step. 23:20:33 INFO - Running pre-action listener: _resource_record_pre_action 23:20:33 INFO - Running pre-action listener: _set_gcov_prefix 23:20:33 INFO - Running main action method: run_tests 23:20:33 WARNING - Try message not found. 23:20:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:20:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:20:33 INFO - Python 2.7.3 23:20:33 INFO - Return code: 0 23:20:33 INFO - grabbing minidump binary from tooltool 23:20:33 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')]} 23:20:33 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 0x1fc6090>, '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 0x1fc6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fc0f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:20:33 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 23:20:33 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 23:20:33 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 23:20:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:20:33 INFO - Return code: 0 23:20:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:20:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:20:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:20:33 INFO - ENV: RUST_BACKTRACE is now full 23:20:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:20:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:20:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Zv5HYUSPS56G-8wZXuIJvw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 23:20:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Zv5HYUSPS56G-8wZXuIJvw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-024 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 23:20:33 INFO - Using env: {'DISPLAY': ':0', 23:20:33 INFO - 'HOME': '/home/cltbld', 23:20:33 INFO - 'LANG': 'en_US.UTF-8', 23:20:33 INFO - 'LANGUAGE': 'en_US:en', 23:20:33 INFO - 'LOGNAME': 'cltbld', 23:20:33 INFO - 'MAIL': '/var/mail/cltbld', 23:20:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:20:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:20:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:20:33 INFO - 'MOZ_NO_REMOTE': '1', 23:20:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:20:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:20:33 INFO - 'NO_EM_RESTART': '1', 23:20:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:20:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:20:33 INFO - 'PWD': '/builds/slave/test', 23:20:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:20:33 INFO - 'RUST_BACKTRACE': 'full', 23:20:33 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 23:20:33 INFO - 'SHELL': '/bin/bash', 23:20:33 INFO - 'SHLVL': '1', 23:20:33 INFO - 'TERM': 'linux', 23:20:33 INFO - 'TMOUT': '86400', 23:20:33 INFO - 'USER': 'cltbld', 23:20:33 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1505362313.990101-395763722', 23:20:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:20:33 INFO - '_': '/tools/buildbot/bin/python'} 23:20:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Zv5HYUSPS56G-8wZXuIJvw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 23:20:33 INFO - mozversion application_buildid: 20170914052917 23:20:33 INFO - mozversion application_changeset: cb717386aec8601a301babd4156aabc4cccff0b0 23:20:33 INFO - mozversion application_display_name: Nightly 23:20:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:20:33 INFO - mozversion application_name: Firefox 23:20:33 INFO - mozversion application_remotingname: firefox 23:20:33 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 23:20:33 INFO - mozversion application_vendor: Mozilla 23:20:33 INFO - mozversion application_version: 57.0a1 23:20:33 INFO - mozversion platform_buildid: 20170914052917 23:20:33 INFO - mozversion platform_changeset: cb717386aec8601a301babd4156aabc4cccff0b0 23:20:33 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 23:20:33 INFO - mozversion platform_version: 57.0a1 23:20:33 INFO - using testdate: 1505370033 23:20:33 INFO - actual date: 1505370033 23:20:33 INFO - starting webserver on 'localhost:33652' 23:20:33 INFO - SUITE-START | Running 2 tests 23:20:33 INFO - TEST-START | dromaeo_css 23:20:33 INFO - Initialising browser for dromaeo_css test... 23:20:33 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:33652/getInfo.html -profile /tmp/tmpK01h6j/profile 23:20:33 INFO - TEST-INFO | started process 31473 (/builds/slave/test/build/application/firefox/firefox http://localhost:33652/getInfo.html) 23:20:39 INFO - TEST-INFO | 31473: exit 0 23:20:39 INFO - Browser initialized. 23:20:39 INFO - Running cycle 1/1 for dromaeo_css test... 23:20:39 INFO - Using env: {'DISPLAY': ':0', 23:20:39 INFO - 'HOME': '/home/cltbld', 23:20:39 INFO - 'JSGC_DISABLE_POISONING': '1', 23:20:39 INFO - 'LANG': 'en_US.UTF-8', 23:20:39 INFO - 'LANGUAGE': 'en_US:en', 23:20:39 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 23:20:39 INFO - 'LOGNAME': 'cltbld', 23:20:39 INFO - 'MAIL': '/var/mail/cltbld', 23:20:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:20:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:20:39 INFO - 'MOZ_CRASHREPORTER': '1', 23:20:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:20:39 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 23:20:39 INFO - 'MOZ_NO_REMOTE': '1', 23:20:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:20:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:20:39 INFO - 'NO_EM_RESTART': '1', 23:20:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:20:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:20:39 INFO - 'PWD': '/builds/slave/test', 23:20:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:20:39 INFO - 'RUST_BACKTRACE': 'full', 23:20:39 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 23:20:39 INFO - 'SHELL': '/bin/bash', 23:20:39 INFO - 'SHLVL': '1', 23:20:39 INFO - 'TERM': 'linux', 23:20:39 INFO - 'TMOUT': '86400', 23:20:39 INFO - 'USER': 'cltbld', 23:20:39 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1505362313.990101-395763722', 23:20:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:20:39 INFO - '_': '/tools/buildbot/bin/python'} 23:20:39 INFO - TEST-INFO | started process 31709 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpK01h6j/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 23:20:40 INFO - PID 31709 | 23:20:40 INFO - PID 31709 | (/builds/slave/test/build/application/firefox/firefox:31759): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 23:20:40 INFO - PID 31709 | 23:20:50 INFO - PID 31709 | RSS: Main: 176353280 23:20:50 INFO - PID 31709 | 23:23:48 INFO - PID 31709 | Cycle 1(1): loaded http://localhost:33652/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33652/tests/dromaeo/cssquery-ext.html) 23:23:49 INFO - PID 31709 | RSS: Main: 178745344 23:23:49 INFO - PID 31709 | 23:26:51 INFO - PID 31709 | Cycle 1(1): loaded http://localhost:33652/tests/dromaeo/cssquery-ext.html (next: http://localhost:33652/tests/dromaeo/cssquery-jquery.html) 23:26:51 INFO - PID 31709 | RSS: Main: 175333376 23:26:51 INFO - PID 31709 | 23:29:53 INFO - PID 31709 | Cycle 1(1): loaded http://localhost:33652/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33652/tests/dromaeo/cssquery-mootools.html) 23:29:54 INFO - PID 31709 | RSS: Main: 177426432 23:29:54 INFO - PID 31709 | 23:32:55 INFO - PID 31709 | Cycle 1(1): loaded http://localhost:33652/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33652/tests/dromaeo/cssquery-prototype.html) 23:32:56 INFO - PID 31709 | RSS: Main: 175525888 23:32:56 INFO - PID 31709 | 23:36:00 INFO - PID 31709 | Cycle 1(1): loaded http://localhost:33652/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33652/tests/dromaeo/cssquery-yui.html) 23:36:00 INFO - PID 31709 | RSS: Main: 176832512 23:36:00 INFO - PID 31709 | 23:39:02 INFO - PID 31709 | Cycle 1(1): loaded http://localhost:33652/tests/dromaeo/cssquery-yui.html (next: http://localhost:33652/tests/dromaeo/cssquery-dojo.html) 23:39:02 INFO - PID 31709 | RSS: Main: 179503104 23:39:02 INFO - PID 31709 | 23:39:02 INFO - PID 31709 | __start_tp_report 23:39:02 INFO - PID 31709 | _x_x_mozilla_page_load 23:39:02 INFO - PID 31709 | _x_x_mozilla_page_load_details 23:39:02 INFO - PID 31709 | |i|pagename|runs| 23:39:02 INFO - PID 31709 | |0;dojo.html;3133.8903138390156;3142.1987393214727;3193.042087373787;3196.2009497625595;3200.5199220116992;6258.968705156479;6313.652749098809;6364.840878978028;6418.454431373333;6475.805725828227;6321.525885558579;6373.649449280288;6393.584417012891;6402.839929001777;6421.325760795119;5818.970905145479;5853.473187413132;5908.291005079396;5921.378255283176;5930.288365396159;5779.768809247625;5889.676067816268;5891.88216235675;5906.704664766766;5948.256467941507;5471.398146203915;5782.3350314713925;5792.420757924195;5918.615290006136;5923.674197919135;5834.329052159013;5859.560532960045;5942.286925568917;5950.5834591578605;5955.940440595626;5804.187413762077;5849.795257166022;5857.326407463153;5927.199828023248;5930.169776231331;6332.588381755171;6357.237131544244;6371.872562548723;6397.904031439532;6410.358964103599;6892.207396149407;6916.861662766716;6926.792196234121;6944.861102777967;6953.408960238386;6901.861962760717;6902.5858448492745;6928.16861976561;6998.860022799516;7007.614581198032;6259.0924315973925;6329.841753956096;6337.493000559944;6418.03729440583;6477.125588045601;6927.272636373108;6942.514024018371;6971.58170509771;6980;7004.929950700428;6683.030960510699;6688.799336019927;6694.49791265657;6695.029220762962;6715.865682686416;6815.386615204656;6816;6940.826479338057;6942.20164681058;6953.687084081229;6842.931570684329;6855;6909.896351554731;6918.411934985583;6927.203371612229;6874.553154044971;6880.2431732509385;6888.931110688829;6974.232834388214;6980.616066116311;5273;5359.249705041298;5368.5436737876935;5381.273528073738;5381.5694744421135;4653.697509661861;4754.690945088558;4770.165221086296;4789.018251258483;4810.39870016248;5858.970705146447;5876.941230587639;5920.467157955804;5948.375420580776;5951.821445356646;6894.862102757917;6915.89626155608;6955.617441040791;6990.405815505637;6995.510314277952;5735.1970724098655;5824.039033559416;5827.184194212814;5828.825135245949;5829.067349224104;5856.12158176277;5942.61373010753;5945.613535120204;5948.196993405922;5955.106733989849;6663.500237482208;6676.6327851967635;6731.2932142125355;6741.056252124707;6747.089142965735;6912.792616221522;6913.5506192097355;6924;7014.333638304455;7025.156981162293;6447.871042579216;6475.7733479328;6554.606723596599;6604.075429439787;6734.528582999143;6750.932490675031;6794.966025169842;6825.180978282638;6837.179538455218;6868.313168683291;6871.484638652021;6875.449964002768;6943.965280173769;6967.651617419007;6968.6864091115;6554.606723596599;6630.83422914431;6635.369639884203;6721.059051732664;6730.528862979741;6624.90062649051;6628.536002479973;6630.502712296694;6636.43590294811;6637.701303441453;6486.481081513562;6492.28584855656;6509.1863517060365;6560.803175904731;6575.178102737158;6744.662766861736;6805.625690587065;6808.523403361915;6845.965770171118;6859.2454829969665;6381.8085457436355;6487.610743355413;6512.413882750386;6535.57518761279;6633.933660663524 23:39:02 INFO - PID 31709 | |1;ext.html;801.9318357939578;813.6257321632049;832.7543374704461;838.9973981092593;843.0389356134004;40369;41649.50102993823;41654;41807;42008.789956050176;38718.419223711666;39131.21737565247;39436.21127577447;39485.60514394855;39500.80249598748;7081.822954426142;7193.640317984106;7198.208197098315;7198.964005179967;7216.206217316091;7085.610291433969;7167.964160179192;7675.078990521118;7906.486078404885;7945.602719863984;7921.04947406312;7959;7964.8805267921025;7968.362530997535;7969.721059762909;7248.855022899539;7765.1070126935565;7804.687812487494;7823.0612326520895;7910.2089791020435;7792.766217013499;7847.843043139163;7863.449558530905;7864.331531819802;7864.41016923733;37485.437718434245;38061;38129.046773830596;38160.236795264216;38165;3553.573571171476;3590.8922732318074;3591;3591.120175557005;3596.982015089934;31789.205269868206;31918.840405798055;31960.84019579887;31963;32072.679273207203;5224.92162617561;5240.475952404767;5243.79024839006;5256.2904007959205;5264.473552644743;184585;185569;185803;186160;186884;47882.521174788504;47905.281420778716;48037.519624804;48091;48114;49913.75043124761;49918;49997.50002500001;50070.74964625226;50092.749536252086;16132.516024519284;16278.186090695655;16307.592310192103;16323.428679996143;16327.83672163287;13351.731585499361;13357.13178643385;13441.462341506425;13461;13479.663008424868;14097.154170749787;14137.505187318395;14225.577442255899;14316.498922537661;14407.42370305176;5715.971420142872;5843;5931.606072572942;6051.788187413419;6077.24034495688;960.500539719342;980.2892902645667;998.3111652959435;998.3909815012836;1003.94478303694;22196.223132190295;22329.665055024187;22399.32802015942;22550.774492255197;22561.887190563943;1063.8191607315873;1079.09895237476;1085.7882712870914;1088.1892989722548;1091.8525998990035;11845.644630661094;11876.762464750656;11898.583549575724;11974;12029.518819247307;232752;233653;234637;234686;235139;45836.5416345839;46757;46857;47723.5227647726;52719;1455.890808189369;1461.6199788055183;1463.2829913342387;1474.675571374296;1476.9704605907607;26002.739972600033;26108.477830442906;26167.73832261653;26332.21003369902;27049.1885243443;37547;37593.24813503769;37689;37797.9999999989;37900.62099378971;198068;198239;198397;198439;198552;33087.66912330846;33142.337153257286;33240.33519329648;33402.49896251607;33439;41487.58512414837;42885.356719648604;42931.35602965896;43546;43618;31163.688363116078;31444.842775785975;31448.68551314549;31844.52233216457;32346;31510.52734208943;31533.526997094603;31545.8422707885;31707.365852683277;31709;35327.47008794819;35528.822355888056;35553.11117221987;35689.46465802963;35749.46375804313;31230.37539249157;31236;31319.68680313259;32028.359432811678;32031.6796832038;23089.65365519485;23362.378831281178;23726;23759.287221383387;23966.760332396454 23:39:02 INFO - PID 31709 | |2;jquery.html;569.4703925349426;569.8461415417837;572.7107810555668;578.3349148479248;580.5094694982739;21863.67204491932;21975.450613734665;22610.208642697507;22676.206332778354;22703;26241.34396640085;27266.318342041457;27299.590506142373;27333.316667083334;27388;6976.127984002;6984.615846128461;7034.155901291852;7080.929190708104;7108.928910710878;6865.382115609594;7226.494145409823;7245.347918687317;7247.927520724778;7253.927460725378;7216.530925489827;7221.4944953853255;7225.602591857446;7226.6025368604705;7230.493865429422;7226.096737907762;7227;7227.277272272757;7233.529820561699;7235.71057157713;7066.9646651766925;7069.081019467488;7081.398081163107;7093;7095.82260443493;29970.55044174339;31337.37325253482;31338.21654458634;31345.686543134503;31365.37269254602;2154.859934104294;2185.2570126157025;2188.912443502258;2189.8905054747197;2193.078906859107;20470.488237794176;21036.05337759789;21147.577048459098;21157;21264.574708505745;2513.3465299022387;2560.295918622375;2609.4781043791127;2636.380450594109;2652.6286319915225;134823;138528;140723;141336;141876.99999999898;20489.692654610193;20738.44461665381;20822;21693;21979.04377212085;43485.13029739387;43549.564504355185;43567.56432435699;43574.56425435768;43592.948493605145;11567.479463423997;11623.244489108181;11657.18399712029;11866.466009029615;11875.524979000917;9203.585838637144;9564.56959436827;9564.66523671668;9613.951930240444;9893.75265618351;9200;9268.490233037248;9415.952920235355;9421.858672119924;9515.857262141073;2716.1036857836866;2764.1707487753592;2770.3766652503427;2777.4583956128763;2849.7150284971335;944.9244060475146;973.2894986659778;983.3657291047234;992.699274910924;998.2712619787595;19944;20034.69947950782;20270.79729202689;20379;20516;1052.8052310322614;1055.3773273768513;1061.9787604247872;1063.2557209953063;1064.7018834726289;10967.780644387067;11273.492692828842;11303.434828258554;11359.602413915472;11368.147388945863;479090;490931;493518;496648;497525.5371169435;108784.64861405613;109125;111336.4433177845;111443.44278278718;111632;1170.0990237517065;1179.504608064615;1200.0819373179525;1200.1119171812795;1207.1549915059318;17891.67408236921;17960.730589041435;18128.184231709867;18306.90846545759;18356.816431835512;53944.73027634837;55006.44993550013;56020;56124;56544.43455565392;69923.65038174776;70592.6470367645;71023.28976710167;71071.64464177647;71483;14388.28058597087;14699.632509187355;14708;14723.852761472248;14968;23081.192158274378;23337.41656458602;23349.182778603346;23407.180748673716;23418.297451076494;18087.457376278733;18372.17325220395;18375.26498940081;18523.536911577317;18527;15117.697646047238;15878.285477153788;16185.838141618433;16765.329386824877;16831.91584042072;18837.434876953714;18965.810341896406;19055.428337149908;19200.8079919199;19351.322703705304;14570.125792452487;14591.343389547283;14631;14666.926665366605;14689.412423503367;18045.36841210604;18477.260909563465;18624.255029798656;18635.44093677192;18642.34751783681 23:39:02 INFO - PID 31709 | |3;mootools.html;1303.1399276477523;1374.1960952842587;1400.362834910116;1401.558509069643;1408.8591140885912;14960.625984350396;15421.537353879401;15473.30370133344;15550.53348399547;15620.2970866311;15206.54380368588;15277.083374997508;15304.69390612187;15413.614659633515;15439.614009649764;2691.690455597607;2694.137875879719;2776.986115069432;2778.305423644089;2785.5125353063236;2705.8917643294244;2718.7824974002033;2721.9319517012136;2723.3872378714827;2724.359775452767;2635.8550279734704;2668.026170447792;2668.3062403774966;2669.5728683410657;2671.3722275265295;2582.702989156243;2617.790576753855;2619.7118316985116;2619.908303209388;2620.2401303621928;2602.46649436865;2602.713701492853;2613.529564678357;2614.6208799724122;2615.5292047431453;14431.927840360837;14552.563423097325;14674.853251467455;14694.926525367411;14700.70598588033;7256.4920455568135;7527.811804704871;7530.209328020534;7532.39740820733;7544.245575442466;4916.852494425173;5047.2429135629945;5206.062908676437;5241.3710354757295;5317.282166907496;1896.5163883209832;1911.5030092176135;2332.207049603126;2339.6256598944087;2363.0902102690416;26777.330566735793;27045.864770676217;27151.592726109124;27169.184924452296;27213.183604491896;6711.429528490035;6745.797626071226;6849.417799487;6920.826979325457;6972.721091156297;17172.570685732706;17187.398441054753;17242.827571724374;17250;17262.65474690499;7802.492837965514;7951.642176102089;7958.363330933512;7980.201979801974;7984.20157984197;7146.821329466701;7307.671154798047;7396.889046664304;7446.10646722386;7447.143578488435;5128.410232823273;5179.689218646818;5198.2722418861385;5239.580833533309;5282.31329927107;1502.8196616405883;1506.412499125342;1509.3736099518796;1516.5374560758853;1523.3601887207178;901.256463417683;916.3585490156917;918.4994178172778;919.6229545886155;938.3666025432942;7582.317591416689;7696.384289256846;7737.342325902361;7790.376769858511;7860.213978602094;705.2876594639451;715.1025463043846;723.5297056912943;730.3645828129561;735.4153448008846;4727.550882666142;4845.878853028703;5063.797448102108;5085.923711144335;5205.713685747321;20034;20428.489287767923;20641.89679051625;21136.577268454854;21641;20311.796882031285;20324.898375508026;20504.38486845397;21388.465288367915;21499;9316.673916412892;9588;10085.69742907714;11213.439328033566;11305.660830175273;8735.606897689491;8994.910050899407;9072.410293330913;9084.18242358191;9123.315751318545;18237.270509180016;18322.26710931601;18474.261029558667;18834.905825470785;19194.328198512983;19226.90386548114;19488.61022779565;19536.706949395488;19885.304014359426;19979.300724474575;9987.051230133126;10558.260921735406;10558.313709609158;10605.098566621924;10619.840702389316;13832.654183645489;14060.507882224481;14066.578002659937;14067.859321407064;14068.577942661737;11253;11283;11332.830007549728;11373.374464404536;11497.137714671266;11017.173711971474;11144.888551114385;11237.887621123684;11280.661580152608;11316.26444281119;9966.451845148586;10074.597016119273;10114.797704046025;10154.39073655583;10161.085502304828;7278.09023872016;7344.48588598793;7353.889691654523;7371.631418429164;7384.9261507384235;7416.629168541659;7456.254374562501;7456.96271518639;7520.398368130646;7594.962025189839 23:39:02 INFO - PID 31709 | |4;prototype.html;496.66950662226003;503.20857746422763;513.8432778002709;523.9109351410265;526.2264471227295;6128.509719222463;6215.5338349623735;6238.812835614927;6375.234971803378;6403.175095097898;6300.369963003697;6304;6354.61872287663;6363.681815909209;6379.138816259803;5282.894342113155;5286.497782710637;5301.628885977983;5325.961437519685;5338.439463856278;4879.487653796354;5073.086844368012;5092.185250359943;5309.787608495655;5322.179245000137;5026.623003274751;5052.317937078503;5054.039732450822;5089.491050894918;5090.9236361454605;4995.200767877122;5013.3482647255805;5024.447310795809;5026.8240611578785;5034.521720436571;4508.301213311942;4511.6165125964335;4523.47979982303;4526.88682782933;4564.954350456486;6241.157443745082;6255.7184926677955;6256.562040657156;6269.717862696144;6271.773520400237;5688.288963879515;5690.971545142289;5794.5074668653215;5801.970990145064;5846.269216347957;6460.3862633049785;6547.9345206547805;6579.80260592183;6589.835254118638;6624.93375066248;4876.536729010738;4888.951110488921;4894.8042078317185;4906.31311616374;4923.6952207665;6853;6937;6939.306069393071;6974.151849759818;7107.573545587281;4940.283658869444;4988.5260900214425;5002.874928126826;5029.1450453423;5035.748212589356;5087.31321271631;5114.3862736471865;5121.513456221653;5129.666571672829;5138.2292656101135;5698.7747634258;5745.8563535911935;5775.826725198251;5778.451047150514;5793.8841223175305;6598.9873088707445;6692.665366731644;6694.765683201064;6705.463562914955;6710.899336509956;1652.6861145389444;1707.2658756734475;1734.3236137906226;1761.1722490429477;1780.4213630570116;1207.9879201207875;1230.6185082624415;1241.8696036916174;1248.9812652810215;1249.956251531192;5708.543316534668;5727.312722473246;5747.195392645033;5749.626274292157;5799.652020878761;6533.771318003942;6667.499937504706;6671.3328667133865;6733.595984240961;6746.359095885883;5663.9716801415725;5690.374058853523;5745.569082318842;5752.798652047242;5803.854903627359;3503.160840558727;3577.4454959481322;3599.856005759793;3603.4774957631;3627.9093022674115;6441.872672282426;6455.4835613150835;6495.740170393131;6497.805065848032;6544.574602650812;6751.966240168866;6867.695137923779;6893.517453778188;6910.550814197061;6984.860302793915;6560.737570497126;6579.243387010555;6594.670266486753;6604.273529911706;6625.834354141089;6767.695453704693;6829.282925292971;6837.153968428596;6856.622885741132;6863.245043045361;6601.867962640624;6615.04081908111;6688;6816.522843401112;6841.657917104026;6342.809715708536;6471.741130354922;6473.77341793035;6536.8365790855605;6582.901256481253;4936.160852655129;4978.2034874419915;4985.875353116056;5020.221865610836;5033.471485494117;6775.695093720893;6785.253622101466;6790.42281406086;6791.592504449749;6819.420349270169;6367.745290188341;6393.200849893763;6395.16862807832;6505.316941721051;6529.314421985623;6218.906716399348;6417.39034791694;6456.418177546531;6491.350864913471;6507.837304067436;6329.620222786648;6387.968060159856;6406.871862562816;6417.26201486835;6472.449841763503;6491.318411566906;6536.901946470902;6577.2436169841085;6672.83317917056;6680.365365290289;6218.315985241529;6318.368163183645;6323.849891037069;6358.364163583605;6397.26431460388 23:39:02 INFO - PID 31709 | |5;yui.html;888.0630934364248;908.9636414543419;916.7753900294429;923.8752768376269;935.9859602105968;18980.90509547452;19882.900585497053;19926.90036549817;19934.40196794097;19953.900230498864;17002.744958825628;17132.229049692764;17245.655086898256;17287.567810804736;17289.135543222852;951.115462619765;963.4508330251759;966.3235734985539;966.5167416291854;966.8936416994125;982.3860087445347;982.8132654795565;982.9361091529064;983.537737263485;983.965561205358;983.72947439454;1014.5535964175739;1015.28422462164;1017.1252722658508;1018.7300365403174;1008.757898104457;1009.0313299232745;1009.0615727373539;1009.0666133826255;1016.806806706727;729.6752944939504;736.5507040705165;737.5943231222859;742.0279433941554;757.5795433534386;17411.5647108822;17444.91277543617;17475;17486.737698934525;17496.91251543734;21380.144794208212;21728.34814955554;21758.238461653924;21963.670544941837;22225.44436389103;17631.647367052716;17952.371666991723;18000.90999545007;18141.09294535268;18143.909280453645;3773.867914622975;3795.6014618464937;3799.810009499514;3800.657940785343;3801.8669346573015;108450.91549084565;142905.285473573;146288.26855865758;147081;147563.52436475604;17373.391931282345;18068.548286292684;18169.091545422674;18263.45209643713;18315;29300.706992930223;29892.55161172584;29905;29928.850355748084;30046.399072018437;9002.549872506348;9159.404638698463;9161.17549420542;9311.627534898664;9323.90676093244;4333.43665323506;4399.318105693623;4415.205263052617;4419.270820314677;4425.668074894395;5373.059714549938;5400.297961265089;5469.343678758574;5491.148871924858;5499.945000549943;1097.6816723150357;1102.32207192576;1123.4326665034105;1125.9493322800495;1130.0507573638183;702.2240424331143;704.1409480433863;718.3104219948907;723.565860483716;725.3906718356606;11797.941010294893;12225.755484890253;12462.783704124759;13269.270190139441;13336.199828010156;705.3510770091528;707.0596107177441;707.1549498349423;715.1275443958363;720.6901032555946;5682.374938756733;5764.481196692318;5789.565782566325;5865.970670146622;5936.495397891142;125950.37024814817;127720.36139819241;129927;130968.3451582736;133473.33263333622;110473.44763276292;110873.44563277133;112905;114858.42570787092;115545;97012.51493742486;97996;98928.01071989333;100123.49938250262;100333;10749.66760304277;10793.784124317313;10856.294340867818;10950.835737464104;11202.49588768491;44026.33960490531;44405.55594444143;46094;46460.30309545292;48003.27995080007;57865.42134578769;57890.710546447;59076.70461647664;59544.404555953886;60231.397686024335;15984.760228596348;16323.18384080815;16384.918075409547;16508.587285317964;16534.09062501526;18091.54771130732;18355.724664129782;18482.907585462526;18499.537511562317;18536.44390668282;15728;15845.128517931624;15848.762268566212;15992.600184995003;16032.759508607147;16318.26567804428;16460.176991150634;16481.67036659236;16704.665906682043;16730.665386692443;15874.682506349578;16061.27724252388;16095.356185752908;16137;16270.349186032427;11228.214025018497;11435.428228588371;11612.187146899636;11624.535018599161;11653.475593598478;12043.819342710041;12132.939335303266;12213.389330533615;12335.753284934071;12393.504259829866 23:39:02 INFO - PID 31709 | __end_tp_report 23:39:02 INFO - PID 31709 | __start_cc_report 23:39:02 INFO - PID 31709 | _x_x_mozilla_cycle_collect,367 23:39:02 INFO - PID 31709 | __end_cc_report 23:39:02 INFO - PID 31709 | __startTimestamp1505371142431__endTimestamp 23:39:02 INFO - PID 31709 | 23:39:02 INFO - PID 31709 | ------- Summary: start ------- 23:39:02 INFO - PID 31709 | Number of tests: 6 23:39:02 INFO - PID 31709 | 23:39:02 INFO - PID 31709 | [#0] dojo.html Cycles:165 Average:6304.42 Median:6512.41 stddev:771.20 (11.8%) stddev-sans-first:732.36 23:39:02 INFO - PID 31709 | Values: 3133.9 3142.2 3193.0 3196.2 3200.5 6259.0 6313.7 6364.8 6418.5 6475.8 6321.5 6373.6 6393.6 6402.8 6421.3 5819.0 5853.5 5908.3 5921.4 5930.3 5779.8 5889.7 5891.9 5906.7 5948.3 5471.4 5782.3 5792.4 5918.6 5923.7 5834.3 5859.6 5942.3 5950.6 5955.9 5804.2 5849.8 5857.3 5927.2 5930.2 6332.6 6357.2 6371.9 6397.9 6410.4 6892.2 6916.9 6926.8 6944.9 6953.4 6901.9 6902.6 6928.2 6998.9 7007.6 6259.1 6329.8 6337.5 6418.0 6477.1 6927.3 6942.5 6971.6 6980.0 7004.9 6683.0 6688.8 6694.5 6695.0 6715.9 6815.4 6816.0 6940.8 6942.2 6953.7 6842.9 6855.0 6909.9 6918.4 6927.2 6874.6 6880.2 6888.9 6974.2 6980.6 5273.0 5359.2 5368.5 5381.3 5381.6 4653.7 4754.7 4770.2 4789.0 4810.4 5859.0 5876.9 5920.5 5948.4 5951.8 6894.9 6915.9 6955.6 6990.4 6995.5 5735.2 5824.0 5827.2 5828.8 5829.1 5856.1 5942.6 5945.6 5948.2 5955.1 6663.5 6676.6 6731.3 6741.1 6747.1 6912.8 6913.6 6924.0 7014.3 7025.2 6447.9 6475.8 6554.6 6604.1 6734.5 6750.9 6795.0 6825.2 6837.2 6868.3 6871.5 6875.4 6944.0 6967.7 6968.7 6554.6 6630.8 6635.4 6721.1 6730.5 6624.9 6628.5 6630.5 6636.4 6637.7 6486.5 6492.3 6509.2 6560.8 6575.2 6744.7 6805.6 6808.5 6846.0 6859.2 6381.8 6487.6 6512.4 6535.6 6633.9 23:39:02 INFO - PID 31709 | 23:39:02 INFO - PID 31709 | [#1] ext.html Cycles:180 Average:37354.98 Median:35719.46 stddev:53599.68 (150.1%) stddev-sans-first:53679.76 23:39:02 INFO - PID 31709 | Values: 801.9 813.6 832.8 839.0 843.0 40369.0 41649.5 41654.0 41807.0 42008.8 38718.4 39131.2 39436.2 39485.6 39500.8 7081.8 7193.6 7198.2 7199.0 7216.2 7085.6 7168.0 7675.1 7906.5 7945.6 7921.0 7959.0 7964.9 7968.4 7969.7 7248.9 7765.1 7804.7 7823.1 7910.2 7792.8 7847.8 7863.4 7864.3 7864.4 37485.4 38061.0 38129.0 38160.2 38165.0 3553.6 3590.9 3591.0 3591.1 3597.0 31789.2 31918.8 31960.8 31963.0 32072.7 5224.9 5240.5 5243.8 5256.3 5264.5 184585.0 185569.0 185803.0 186160.0 186884.0 47882.5 47905.3 48037.5 48091.0 48114.0 49913.8 49918.0 49997.5 50070.7 50092.7 16132.5 16278.2 16307.6 16323.4 16327.8 13351.7 13357.1 13441.5 13461.0 13479.7 14097.2 14137.5 14225.6 14316.5 14407.4 5716.0 5843.0 5931.6 6051.8 6077.2 960.5 980.3 998.3 998.4 1003.9 22196.2 22329.7 22399.3 22550.8 22561.9 1063.8 1079.1 1085.8 1088.2 1091.9 11845.6 11876.8 11898.6 11974.0 12029.5 232752.0 233653.0 234637.0 234686.0 235139.0 45836.5 46757.0 46857.0 47723.5 52719.0 1455.9 1461.6 1463.3 1474.7 1477.0 26002.7 26108.5 26167.7 26332.2 27049.2 37547.0 37593.2 37689.0 37798.0 37900.6 198068.0 198239.0 198397.0 198439.0 198552.0 33087.7 33142.3 33240.3 33402.5 33439.0 41487.6 42885.4 42931.4 43546.0 43618.0 31163.7 31444.8 31448.7 31844.5 32346.0 31510.5 31533.5 31545.8 31707.4 31709.0 35327.5 35528.8 35553.1 35689.5 35749.5 31230.4 31236.0 31319.7 32028.4 32031.7 23089.7 23362.4 23726.0 23759.3 23966.8 23:39:02 INFO - PID 31709 | 23:39:02 INFO - PID 31709 | [#2] jquery.html Cycles:180 Average:35727.01 Median:23209.30 stddev:82589.34 (355.8%) stddev-sans-first:82778.84 23:39:02 INFO - PID 31709 | Values: 569.5 569.8 572.7 578.3 580.5 21863.7 21975.5 22610.2 22676.2 22703.0 26241.3 27266.3 27299.6 27333.3 27388.0 6976.1 6984.6 7034.2 7080.9 7108.9 6865.4 7226.5 7245.3 7247.9 7253.9 7216.5 7221.5 7225.6 7226.6 7230.5 7226.1 7227.0 7227.3 7233.5 7235.7 7067.0 7069.1 7081.4 7093.0 7095.8 29970.6 31337.4 31338.2 31345.7 31365.4 2154.9 2185.3 2188.9 2189.9 2193.1 20470.5 21036.1 21147.6 21157.0 21264.6 2513.3 2560.3 2609.5 2636.4 2652.6 134823.0 138528.0 140723.0 141336.0 141877.0 20489.7 20738.4 20822.0 21693.0 21979.0 43485.1 43549.6 43567.6 43574.6 43592.9 11567.5 11623.2 11657.2 11866.5 11875.5 9203.6 9564.6 9564.7 9614.0 9893.8 9200.0 9268.5 9416.0 9421.9 9515.9 2716.1 2764.2 2770.4 2777.5 2849.7 944.9 973.3 983.4 992.7 998.3 19944.0 20034.7 20270.8 20379.0 20516.0 1052.8 1055.4 1062.0 1063.3 1064.7 10967.8 11273.5 11303.4 11359.6 11368.1 479090.0 490931.0 493518.0 496648.0 497525.5 108784.6 109125.0 111336.4 111443.4 111632.0 1170.1 1179.5 1200.1 1200.1 1207.2 17891.7 17960.7 18128.2 18306.9 18356.8 53944.7 55006.4 56020.0 56124.0 56544.4 69923.7 70592.6 71023.3 71071.6 71483.0 14388.3 14699.6 14708.0 14723.9 14968.0 23081.2 23337.4 23349.2 23407.2 23418.3 18087.5 18372.2 18375.3 18523.5 18527.0 15117.7 15878.3 16185.8 16765.3 16831.9 18837.4 18965.8 19055.4 19200.8 19351.3 14570.1 14591.3 14631.0 14666.9 14689.4 18045.4 18477.3 18624.3 18635.4 18642.3 23:39:02 INFO - PID 31709 | 23:39:02 INFO - PID 31709 | [#3] mootools.html Cycles:180 Average:9262.32 Median:2628.05 stddev:6659.91 (253.4%) stddev-sans-first:6651.75 23:39:02 INFO - PID 31709 | Values: 1303.1 1374.2 1400.4 1401.6 1408.9 14960.6 15421.5 15473.3 15550.5 15620.3 15206.5 15277.1 15304.7 15413.6 15439.6 2691.7 2694.1 2777.0 2778.3 2785.5 2705.9 2718.8 2721.9 2723.4 2724.4 2635.9 2668.0 2668.3 2669.6 2671.4 2582.7 2617.8 2619.7 2619.9 2620.2 2602.5 2602.7 2613.5 2614.6 2615.5 14431.9 14552.6 14674.9 14694.9 14700.7 7256.5 7527.8 7530.2 7532.4 7544.2 4916.9 5047.2 5206.1 5241.4 5317.3 1896.5 1911.5 2332.2 2339.6 2363.1 26777.3 27045.9 27151.6 27169.2 27213.2 6711.4 6745.8 6849.4 6920.8 6972.7 17172.6 17187.4 17242.8 17250.0 17262.7 7802.5 7951.6 7958.4 7980.2 7984.2 7146.8 7307.7 7396.9 7446.1 7447.1 5128.4 5179.7 5198.3 5239.6 5282.3 1502.8 1506.4 1509.4 1516.5 1523.4 901.3 916.4 918.5 919.6 938.4 7582.3 7696.4 7737.3 7790.4 7860.2 705.3 715.1 723.5 730.4 735.4 4727.6 4845.9 5063.8 5085.9 5205.7 20034.0 20428.5 20641.9 21136.6 21641.0 20311.8 20324.9 20504.4 21388.5 21499.0 9316.7 9588.0 10085.7 11213.4 11305.7 8735.6 8994.9 9072.4 9084.2 9123.3 18237.3 18322.3 18474.3 18834.9 19194.3 19226.9 19488.6 19536.7 19885.3 19979.3 9987.1 10558.3 10558.3 10605.1 10619.8 13832.7 14060.5 14066.6 14067.9 14068.6 11253.0 11283.0 11332.8 11373.4 11497.1 11017.2 11144.9 11237.9 11280.7 11316.3 9966.5 10074.6 10114.8 10154.4 10161.1 7278.1 7344.5 7353.9 7371.6 7384.9 7416.6 7456.3 7457.0 7520.4 7595.0 23:39:02 INFO - PID 31709 | 23:39:02 INFO - PID 31709 | [#4] prototype.html Cycles:180 Average:5550.43 Median:6248.44 stddev:1550.60 (24.8%) stddev-sans-first:1507.84 23:39:02 INFO - PID 31709 | Values: 496.7 503.2 513.8 523.9 526.2 6128.5 6215.5 6238.8 6375.2 6403.2 6300.4 6304.0 6354.6 6363.7 6379.1 5282.9 5286.5 5301.6 5326.0 5338.4 4879.5 5073.1 5092.2 5309.8 5322.2 5026.6 5052.3 5054.0 5089.5 5090.9 4995.2 5013.3 5024.4 5026.8 5034.5 4508.3 4511.6 4523.5 4526.9 4565.0 6241.2 6255.7 6256.6 6269.7 6271.8 5688.3 5691.0 5794.5 5802.0 5846.3 6460.4 6547.9 6579.8 6589.8 6624.9 4876.5 4889.0 4894.8 4906.3 4923.7 6853.0 6937.0 6939.3 6974.2 7107.6 4940.3 4988.5 5002.9 5029.1 5035.7 5087.3 5114.4 5121.5 5129.7 5138.2 5698.8 5745.9 5775.8 5778.5 5793.9 6599.0 6692.7 6694.8 6705.5 6710.9 1652.7 1707.3 1734.3 1761.2 1780.4 1208.0 1230.6 1241.9 1249.0 1250.0 5708.5 5727.3 5747.2 5749.6 5799.7 6533.8 6667.5 6671.3 6733.6 6746.4 5664.0 5690.4 5745.6 5752.8 5803.9 3503.2 3577.4 3599.9 3603.5 3627.9 6441.9 6455.5 6495.7 6497.8 6544.6 6752.0 6867.7 6893.5 6910.6 6984.9 6560.7 6579.2 6594.7 6604.3 6625.8 6767.7 6829.3 6837.2 6856.6 6863.2 6601.9 6615.0 6688.0 6816.5 6841.7 6342.8 6471.7 6473.8 6536.8 6582.9 4936.2 4978.2 4985.9 5020.2 5033.5 6775.7 6785.3 6790.4 6791.6 6819.4 6367.7 6393.2 6395.2 6505.3 6529.3 6218.9 6417.4 6456.4 6491.4 6507.8 6329.6 6388.0 6406.9 6417.3 6472.4 6491.3 6536.9 6577.2 6672.8 6680.4 6218.3 6318.4 6323.8 6358.4 6397.3 23:39:02 INFO - PID 31709 | 23:39:02 INFO - PID 31709 | [#5] yui.html Cycles:180 Average:24831.83 Median:18289.23 stddev:36332.25 (198.7%) stddev-sans-first:36389.69 23:39:02 INFO - PID 31709 | Values: 888.1 909.0 916.8 923.9 936.0 18980.9 19882.9 19926.9 19934.4 19953.9 17002.7 17132.2 17245.7 17287.6 17289.1 951.1 963.5 966.3 966.5 966.9 982.4 982.8 982.9 983.5 984.0 983.7 1014.6 1015.3 1017.1 1018.7 1008.8 1009.0 1009.1 1009.1 1016.8 729.7 736.6 737.6 742.0 757.6 17411.6 17444.9 17475.0 17486.7 17496.9 21380.1 21728.3 21758.2 21963.7 22225.4 17631.6 17952.4 18000.9 18141.1 18143.9 3773.9 3795.6 3799.8 3800.7 3801.9 108450.9 142905.3 146288.3 147081.0 147563.5 17373.4 18068.5 18169.1 18263.5 18315.0 29300.7 29892.6 29905.0 29928.9 30046.4 9002.5 9159.4 9161.2 9311.6 9323.9 4333.4 4399.3 4415.2 4419.3 4425.7 5373.1 5400.3 5469.3 5491.1 5499.9 1097.7 1102.3 1123.4 1125.9 1130.1 702.2 704.1 718.3 723.6 725.4 11797.9 12225.8 12462.8 13269.3 13336.2 705.4 707.1 707.2 715.1 720.7 5682.4 5764.5 5789.6 5866.0 5936.5 125950.4 127720.4 129927.0 130968.3 133473.3 110473.4 110873.4 112905.0 114858.4 115545.0 97012.5 97996.0 98928.0 100123.5 100333.0 10749.7 10793.8 10856.3 10950.8 11202.5 44026.3 44405.6 46094.0 46460.3 48003.3 57865.4 57890.7 59076.7 59544.4 60231.4 15984.8 16323.2 16384.9 16508.6 16534.1 18091.5 18355.7 18482.9 18499.5 18536.4 15728.0 15845.1 15848.8 15992.6 16032.8 16318.3 16460.2 16481.7 16704.7 16730.7 15874.7 16061.3 16095.4 16137.0 16270.3 11228.2 11435.4 11612.2 11624.5 11653.5 12043.8 12132.9 12213.4 12335.8 12393.5 23:39:02 INFO - PID 31709 | -------- Summary: end -------- 23:39:02 INFO - PID 31709 | 23:39:03 INFO - TEST-INFO | 31709: exit 0 23:39:03 INFO - TEST-OK | dromaeo_css | took 1109627ms 23:39:03 INFO - TEST-START | kraken 23:39:03 INFO - Initialising browser for kraken test... 23:39:03 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:33652/getInfo.html -profile /tmp/tmpPIVzMP/profile 23:39:03 INFO - TEST-INFO | started process 32085 (/builds/slave/test/build/application/firefox/firefox http://localhost:33652/getInfo.html) 23:39:08 INFO - TEST-INFO | 32085: exit 0 23:39:08 INFO - Browser initialized. 23:39:08 INFO - Running cycle 1/1 for kraken test... 23:39:08 INFO - Using env: {'DISPLAY': ':0', 23:39:08 INFO - 'HOME': '/home/cltbld', 23:39:08 INFO - 'JSGC_DISABLE_POISONING': '1', 23:39:08 INFO - 'LANG': 'en_US.UTF-8', 23:39:08 INFO - 'LANGUAGE': 'en_US:en', 23:39:08 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 23:39:08 INFO - 'LOGNAME': 'cltbld', 23:39:08 INFO - 'MAIL': '/var/mail/cltbld', 23:39:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:39:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:39:08 INFO - 'MOZ_CRASHREPORTER': '1', 23:39:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:39:08 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 23:39:08 INFO - 'MOZ_NO_REMOTE': '1', 23:39:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:39:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:39:08 INFO - 'NO_EM_RESTART': '1', 23:39:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:39:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:39:08 INFO - 'PWD': '/builds/slave/test', 23:39:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:39:08 INFO - 'RUST_BACKTRACE': 'full', 23:39:08 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 23:39:08 INFO - 'SHELL': '/bin/bash', 23:39:08 INFO - 'SHLVL': '1', 23:39:08 INFO - 'TERM': 'linux', 23:39:08 INFO - 'TMOUT': '86400', 23:39:08 INFO - 'USER': 'cltbld', 23:39:08 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1505362313.990101-395763722', 23:39:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:39:08 INFO - '_': '/tools/buildbot/bin/python'} 23:39:08 INFO - TEST-INFO | started process 32317 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPIVzMP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 23:39:09 INFO - PID 32317 | 23:39:09 INFO - PID 32317 | (/builds/slave/test/build/application/firefox/firefox:32367): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 23:39:09 INFO - PID 32317 | 23:39:20 INFO - PID 32317 | RSS: Main: 176218112 23:39:20 INFO - PID 32317 | 23:39:22 INFO - PID 32317 | Cycle 1(1): loaded http://localhost:33652/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33652/tests/kraken/driver.html?testName=audio-beat-detection) 23:39:23 INFO - PID 32317 | RSS: Main: 180539392 23:39:23 INFO - PID 32317 | 23:39:26 INFO - PID 32317 | Cycle 1(1): loaded http://localhost:33652/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33652/tests/kraken/driver.html?testName=audio-dft) 23:39:27 INFO - PID 32317 | RSS: Main: 180932608 23:39:27 INFO - PID 32317 | 23:39:30 INFO - PID 32317 | Cycle 1(1): loaded http://localhost:33652/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33652/tests/kraken/driver.html?testName=audio-fft) 23:39:30 INFO - PID 32317 | RSS: Main: 176439296 23:39:30 INFO - PID 32317 | 23:39:32 INFO - PID 32317 | Cycle 1(1): loaded http://localhost:33652/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33652/tests/kraken/driver.html?testName=audio-oscillator) 23:39:33 INFO - PID 32317 | RSS: Main: 177647616 23:39:33 INFO - PID 32317 | 23:39:35 INFO - PID 32317 | Cycle 1(1): loaded http://localhost:33652/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33652/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:39:36 INFO - PID 32317 | RSS: Main: 177590272 23:39:36 INFO - PID 32317 | 23:39:39 INFO - PID 32317 | Cycle 1(1): loaded http://localhost:33652/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33652/tests/kraken/driver.html?testName=imaging-darkroom) 23:39:40 INFO - PID 32317 | RSS: Main: 180260864 23:39:40 INFO - PID 32317 | 23:39:43 INFO - PID 32317 | Cycle 1(1): loaded http://localhost:33652/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33652/tests/kraken/driver.html?testName=imaging-desaturate) 23:39:44 INFO - PID 32317 | RSS: Main: 180756480 23:39:44 INFO - PID 32317 | 23:39:47 INFO - PID 32317 | Cycle 1(1): loaded http://localhost:33652/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33652/tests/kraken/driver.html?testName=json-parse-financial) 23:39:47 INFO - PID 32317 | RSS: Main: 180858880 23:39:47 INFO - PID 32317 | 23:39:49 INFO - PID 32317 | Cycle 1(1): loaded http://localhost:33652/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33652/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:39:50 INFO - PID 32317 | RSS: Main: 180703232 23:39:50 INFO - PID 32317 | 23:39:51 INFO - PID 32317 | Cycle 1(1): loaded http://localhost:33652/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33652/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:39:52 INFO - PID 32317 | RSS: Main: 180826112 23:39:52 INFO - PID 32317 | 23:39:54 INFO - PID 32317 | Cycle 1(1): loaded http://localhost:33652/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33652/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:39:55 INFO - PID 32317 | RSS: Main: 178114560 23:39:55 INFO - PID 32317 | 23:39:57 INFO - PID 32317 | Cycle 1(1): loaded http://localhost:33652/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33652/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:39:58 INFO - PID 32317 | RSS: Main: 178536448 23:39:58 INFO - PID 32317 | 23:40:01 INFO - PID 32317 | Cycle 1(1): loaded http://localhost:33652/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33652/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:40:02 INFO - PID 32317 | RSS: Main: 178442240 23:40:02 INFO - PID 32317 | 23:40:03 INFO - PID 32317 | Cycle 1(1): loaded http://localhost:33652/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33652/tests/kraken/driver.html?testName=ai-astar) 23:40:04 INFO - PID 32317 | RSS: Main: 179765248 23:40:04 INFO - PID 32317 | 23:40:04 INFO - PID 32317 | __start_tp_report 23:40:04 INFO - PID 32317 | _x_x_mozilla_page_load 23:40:04 INFO - PID 32317 | _x_x_mozilla_page_load_details 23:40:04 INFO - PID 32317 | |i|pagename|runs| 23:40:04 INFO - PID 32317 | |0;ai-astar;110;107;108;108;106;109;109;110;109;109 23:40:04 INFO - PID 32317 | |1;audio-beat-detection;125;117;120;118;114;148;121;115;115;119 23:40:04 INFO - PID 32317 | |2;audio-dft;162;162;162;162;163;161;166;165;173;163 23:40:04 INFO - PID 32317 | |3;audio-fft;73;77;74;74;84;74;73;74;75;116 23:40:04 INFO - PID 32317 | |4;audio-oscillator;85;79;79;79;78;80;79;81;80;78 23:40:04 INFO - PID 32317 | |5;imaging-gaussian-blur;113;113;110;114;115;114;114;114;115;117 23:40:04 INFO - PID 32317 | |6;imaging-darkroom;147;148;149;147;150;151;150;147;148;149 23:40:04 INFO - PID 32317 | |7;imaging-desaturate;94;94;94;94;93;94;94;95;96;94 23:40:04 INFO - PID 32317 | |8;json-parse-financial;54;52;53;53;53;53;54;55;54;52 23:40:04 INFO - PID 32317 | |9;json-stringify-tinderbox;37;38;38;38;37;38;44;38;38;38 23:40:04 INFO - PID 32317 | |10;stanford-crypto-aes;92;75;74;75;75;78;73;80;74;78 23:40:04 INFO - PID 32317 | |11;stanford-crypto-ccm;115;111;115;115;115;113;115;116;114;113 23:40:04 INFO - PID 32317 | |12;stanford-crypto-pbkdf2;171;165;167;176;168;170;169;172;175;174 23:40:04 INFO - PID 32317 | |13;stanford-crypto-sha256-iterative;69;67;66;66;66;64;66;66;66;70 23:40:04 INFO - PID 32317 | __end_tp_report 23:40:04 INFO - PID 32317 | __start_cc_report 23:40:04 INFO - PID 32317 | _x_x_mozilla_cycle_collect,923 23:40:04 INFO - PID 32317 | __end_cc_report 23:40:04 INFO - PID 32317 | __startTimestamp1505371204160__endTimestamp 23:40:04 INFO - PID 32317 | 23:40:04 INFO - PID 32317 | ------- Summary: start ------- 23:40:04 INFO - PID 32317 | Number of tests: 14 23:40:04 INFO - PID 32317 | 23:40:04 INFO - PID 32317 | [#0] ai-astar Cycles:10 Average:108.50 Median:109.00 stddev:1.27 (1.2%) stddev-sans-first:1.22 23:40:04 INFO - PID 32317 | Values: 110.0 107.0 108.0 108.0 106.0 109.0 109.0 110.0 109.0 109.0 23:40:04 INFO - PID 32317 | 23:40:04 INFO - PID 32317 | [#1] audio-beat-detection Cycles:10 Average:121.20 Median:119.50 stddev:9.98 (8.3%) stddev-sans-first:10.49 23:40:04 INFO - PID 32317 | Values: 125.0 117.0 120.0 118.0 114.0 148.0 121.0 115.0 115.0 119.0 23:40:04 INFO - PID 32317 | 23:40:04 INFO - PID 32317 | [#2] audio-dft Cycles:10 Average:163.90 Median:163.00 stddev:3.54 (2.2%) stddev-sans-first:3.69 23:40:04 INFO - PID 32317 | Values: 162.0 162.0 162.0 162.0 163.0 161.0 166.0 165.0 173.0 163.0 23:40:04 INFO - PID 32317 | 23:40:04 INFO - PID 32317 | [#3] audio-fft Cycles:10 Average:79.40 Median:74.00 stddev:13.27 (17.9%) stddev-sans-first:13.87 23:40:04 INFO - PID 32317 | Values: 73.0 77.0 74.0 74.0 84.0 74.0 73.0 74.0 75.0 116.0 23:40:04 INFO - PID 32317 | 23:40:04 INFO - PID 32317 | [#4] audio-oscillator Cycles:10 Average:79.80 Median:79.50 stddev:2.04 (2.6%) stddev-sans-first:0.97 23:40:04 INFO - PID 32317 | Values: 85.0 79.0 79.0 79.0 78.0 80.0 79.0 81.0 80.0 78.0 23:40:04 INFO - PID 32317 | 23:40:04 INFO - PID 32317 | [#5] imaging-gaussian-blur Cycles:10 Average:113.90 Median:114.00 stddev:1.79 (1.6%) stddev-sans-first:1.87 23:40:04 INFO - PID 32317 | Values: 113.0 113.0 110.0 114.0 115.0 114.0 114.0 114.0 115.0 117.0 23:40:04 INFO - PID 32317 | 23:40:04 INFO - PID 32317 | [#6] imaging-darkroom Cycles:10 Average:148.60 Median:149.00 stddev:1.43 (1.0%) stddev-sans-first:1.39 23:40:04 INFO - PID 32317 | Values: 147.0 148.0 149.0 147.0 150.0 151.0 150.0 147.0 148.0 149.0 23:40:04 INFO - PID 32317 | 23:40:04 INFO - PID 32317 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:0.79 (0.8%) stddev-sans-first:0.83 23:40:04 INFO - PID 32317 | Values: 94.0 94.0 94.0 94.0 93.0 94.0 94.0 95.0 96.0 94.0 23:40:04 INFO - PID 32317 | 23:40:04 INFO - PID 32317 | [#8] json-parse-financial Cycles:10 Average:53.30 Median:53.50 stddev:0.95 (1.8%) stddev-sans-first:0.97 23:40:04 INFO - PID 32317 | Values: 54.0 52.0 53.0 53.0 53.0 53.0 54.0 55.0 54.0 52.0 23:40:04 INFO - PID 32317 | 23:40:04 INFO - PID 32317 | [#9] json-stringify-tinderbox Cycles:10 Average:38.40 Median:38.00 stddev:2.01 (5.3%) stddev-sans-first:2.07 23:40:04 INFO - PID 32317 | Values: 37.0 38.0 38.0 38.0 37.0 38.0 44.0 38.0 38.0 38.0 23:40:04 INFO - PID 32317 | 23:40:04 INFO - PID 32317 | [#10] stanford-crypto-aes Cycles:10 Average:77.40 Median:76.50 stddev:5.58 (7.3%) stddev-sans-first:2.33 23:40:04 INFO - PID 32317 | Values: 92.0 75.0 74.0 75.0 75.0 78.0 73.0 80.0 74.0 78.0 23:40:04 INFO - PID 32317 | 23:40:04 INFO - PID 32317 | [#11] stanford-crypto-ccm Cycles:10 Average:114.20 Median:115.00 stddev:1.48 (1.3%) stddev-sans-first:1.54 23:40:04 INFO - PID 32317 | Values: 115.0 111.0 115.0 115.0 115.0 113.0 115.0 116.0 114.0 113.0 23:40:04 INFO - PID 32317 | 23:40:04 INFO - PID 32317 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.70 Median:171.50 stddev:3.59 (2.1%) stddev-sans-first:3.81 23:40:04 INFO - PID 32317 | Values: 171.0 165.0 167.0 176.0 168.0 170.0 169.0 172.0 175.0 174.0 23:40:04 INFO - PID 32317 | 23:40:04 INFO - PID 32317 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:66.00 stddev:1.71 (2.6%) stddev-sans-first:1.58 23:40:04 INFO - PID 32317 | Values: 69.0 67.0 66.0 66.0 66.0 64.0 66.0 66.0 66.0 70.0 23:40:04 INFO - PID 32317 | -------- Summary: end -------- 23:40:04 INFO - PID 32317 | 23:40:04 INFO - PID 32317 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 23:40:04 INFO - TEST-INFO | 32317: exit 0 23:40:04 INFO - TEST-OK | kraken | took 61691ms 23:40:04 INFO - SUITE-END | took 1171s 23:40:05 INFO - Completed test suite (00:19:31) 23:40:05 INFO - javascript benchmark 23:40:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8625.421921899104, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3133.8903138390156, 3142.1987393214727, 3193.042087373787, 3196.2009497625595, 3200.5199220116992, 6258.968705156479, 6313.652749098809, 6364.840878978028, 6418.454431373333, 6475.805725828227, 6321.525885558579, 6373.649449280288, 6393.584417012891, 6402.839929001777, 6421.325760795119, 5818.970905145479, 5853.473187413132, 5908.291005079396, 5921.378255283176, 5930.288365396159, 5779.768809247625, 5889.676067816268, 5891.88216235675, 5906.704664766766, 5948.256467941507, 5471.398146203915, 5782.3350314713925, 5792.420757924195, 5918.615290006136, 5923.674197919135, 5834.329052159013, 5859.560532960045, 5942.286925568917, 5950.5834591578605, 5955.940440595626, 5804.187413762077, 5849.795257166022, 5857.326407463153, 5927.199828023248, 5930.169776231331, 6332.588381755171, 6357.237131544244, 6371.872562548723, 6397.904031439532, 6410.358964103599, 6892.207396149407, 6916.861662766716, 6926.792196234121, 6944.861102777967, 6953.408960238386, 6901.861962760717, 6902.5858448492745, 6928.16861976561, 6998.860022799516, 7007.614581198032, 6259.0924315973925, 6329.841753956096, 6337.493000559944, 6418.03729440583, 6477.125588045601, 6927.272636373108, 6942.514024018371, 6971.58170509771, 6980.0, 7004.929950700428, 6683.030960510699, 6688.799336019927, 6694.49791265657, 6695.029220762962, 6715.865682686416, 6815.386615204656, 6816.0, 6940.826479338057, 6942.20164681058, 6953.687084081229, 6842.931570684329, 6855.0, 6909.896351554731, 6918.411934985583, 6927.203371612229, 6874.553154044971, 6880.2431732509385, 6888.931110688829, 6974.232834388214, 6980.616066116311, 5273.0, 5359.249705041298, 5368.5436737876935, 5381.273528073738, 5381.5694744421135, 4653.697509661861, 4754.690945088558, 4770.165221086296, 4789.018251258483, 4810.39870016248, 5858.970705146447, 5876.941230587639, 5920.467157955804, 5948.375420580776, 5951.821445356646, 6894.862102757917, 6915.89626155608, 6955.617441040791, 6990.405815505637, 6995.510314277952, 5735.1970724098655, 5824.039033559416, 5827.184194212814, 5828.825135245949, 5829.067349224104, 5856.12158176277, 5942.61373010753, 5945.613535120204, 5948.196993405922, 5955.106733989849, 6663.500237482208, 6676.6327851967635, 6731.2932142125355, 6741.056252124707, 6747.089142965735, 6912.792616221522, 6913.5506192097355, 6924.0, 7014.333638304455, 7025.156981162293, 6447.871042579216, 6475.7733479328, 6554.606723596599, 6604.075429439787, 6734.528582999143, 6750.932490675031, 6794.966025169842, 6825.180978282638, 6837.179538455218, 6868.313168683291, 6871.484638652021, 6875.449964002768, 6943.965280173769, 6967.651617419007, 6968.6864091115, 6554.606723596599, 6630.83422914431, 6635.369639884203, 6721.059051732664, 6730.528862979741, 6624.90062649051, 6628.536002479973, 6630.502712296694, 6636.43590294811, 6637.701303441453, 6486.481081513562, 6492.28584855656, 6509.1863517060365, 6560.803175904731, 6575.178102737158, 6744.662766861736, 6805.625690587065, 6808.523403361915, 6845.965770171118, 6859.2454829969665, 6381.8085457436355, 6487.610743355413, 6512.413882750386, 6535.57518761279, 6633.933660663524], "value": 6244.444679744778, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [801.9318357939578, 813.6257321632049, 832.7543374704461, 838.9973981092593, 843.0389356134004, 40369.0, 41649.50102993823, 41654.0, 41807.0, 42008.789956050176, 38718.419223711666, 39131.21737565247, 39436.21127577447, 39485.60514394855, 39500.80249598748, 7081.822954426142, 7193.640317984106, 7198.208197098315, 7198.964005179967, 7216.206217316091, 7085.610291433969, 7167.964160179192, 7675.078990521118, 7906.486078404885, 7945.602719863984, 7921.04947406312, 7959.0, 7964.8805267921025, 7968.362530997535, 7969.721059762909, 7248.855022899539, 7765.1070126935565, 7804.687812487494, 7823.0612326520895, 7910.2089791020435, 7792.766217013499, 7847.843043139163, 7863.449558530905, 7864.331531819802, 7864.41016923733, 37485.437718434245, 38061.0, 38129.046773830596, 38160.236795264216, 38165.0, 3553.573571171476, 3590.8922732318074, 3591.0, 3591.120175557005, 3596.982015089934, 31789.205269868206, 31918.840405798055, 31960.84019579887, 31963.0, 32072.679273207203, 5224.92162617561, 5240.475952404767, 5243.79024839006, 5256.2904007959205, 5264.473552644743, 184585.0, 185569.0, 185803.0, 186160.0, 186884.0, 47882.521174788504, 47905.281420778716, 48037.519624804, 48091.0, 48114.0, 49913.75043124761, 49918.0, 49997.50002500001, 50070.74964625226, 50092.749536252086, 16132.516024519284, 16278.186090695655, 16307.592310192103, 16323.428679996143, 16327.83672163287, 13351.731585499361, 13357.13178643385, 13441.462341506425, 13461.0, 13479.663008424868, 14097.154170749787, 14137.505187318395, 14225.577442255899, 14316.498922537661, 14407.42370305176, 5715.971420142872, 5843.0, 5931.606072572942, 6051.788187413419, 6077.24034495688, 960.500539719342, 980.2892902645667, 998.3111652959435, 998.3909815012836, 1003.94478303694, 22196.223132190295, 22329.665055024187, 22399.32802015942, 22550.774492255197, 22561.887190563943, 1063.8191607315873, 1079.09895237476, 1085.7882712870914, 1088.1892989722548, 1091.8525998990035, 11845.644630661094, 11876.762464750656, 11898.583549575724, 11974.0, 12029.518819247307, 232752.0, 233653.0, 234637.0, 234686.0, 235139.0, 45836.5416345839, 46757.0, 46857.0, 47723.5227647726, 52719.0, 1455.890808189369, 1461.6199788055183, 1463.2829913342387, 1474.675571374296, 1476.9704605907607, 26002.739972600033, 26108.477830442906, 26167.73832261653, 26332.21003369902, 27049.1885243443, 37547.0, 37593.24813503769, 37689.0, 37797.9999999989, 37900.62099378971, 198068.0, 198239.0, 198397.0, 198439.0, 198552.0, 33087.66912330846, 33142.337153257286, 33240.33519329648, 33402.49896251607, 33439.0, 41487.58512414837, 42885.356719648604, 42931.35602965896, 43546.0, 43618.0, 31163.688363116078, 31444.842775785975, 31448.68551314549, 31844.52233216457, 32346.0, 31510.52734208943, 31533.526997094603, 31545.8422707885, 31707.365852683277, 31709.0, 35327.47008794819, 35528.822355888056, 35553.11117221987, 35689.46465802963, 35749.46375804313, 31230.37539249157, 31236.0, 31319.68680313259, 32028.359432811678, 32031.6796832038, 23089.65365519485, 23362.378831281178, 23726.0, 23759.287221383387, 23966.760332396454], "value": 17074.60463479618, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [569.4703925349426, 569.8461415417837, 572.7107810555668, 578.3349148479248, 580.5094694982739, 21863.67204491932, 21975.450613734665, 22610.208642697507, 22676.206332778354, 22703.0, 26241.34396640085, 27266.318342041457, 27299.590506142373, 27333.316667083334, 27388.0, 6976.127984002, 6984.615846128461, 7034.155901291852, 7080.929190708104, 7108.928910710878, 6865.382115609594, 7226.494145409823, 7245.347918687317, 7247.927520724778, 7253.927460725378, 7216.530925489827, 7221.4944953853255, 7225.602591857446, 7226.6025368604705, 7230.493865429422, 7226.096737907762, 7227.0, 7227.277272272757, 7233.529820561699, 7235.71057157713, 7066.9646651766925, 7069.081019467488, 7081.398081163107, 7093.0, 7095.82260443493, 29970.55044174339, 31337.37325253482, 31338.21654458634, 31345.686543134503, 31365.37269254602, 2154.859934104294, 2185.2570126157025, 2188.912443502258, 2189.8905054747197, 2193.078906859107, 20470.488237794176, 21036.05337759789, 21147.577048459098, 21157.0, 21264.574708505745, 2513.3465299022387, 2560.295918622375, 2609.4781043791127, 2636.380450594109, 2652.6286319915225, 134823.0, 138528.0, 140723.0, 141336.0, 141876.99999999898, 20489.692654610193, 20738.44461665381, 20822.0, 21693.0, 21979.04377212085, 43485.13029739387, 43549.564504355185, 43567.56432435699, 43574.56425435768, 43592.948493605145, 11567.479463423997, 11623.244489108181, 11657.18399712029, 11866.466009029615, 11875.524979000917, 9203.585838637144, 9564.56959436827, 9564.66523671668, 9613.951930240444, 9893.75265618351, 9200.0, 9268.490233037248, 9415.952920235355, 9421.858672119924, 9515.857262141073, 2716.1036857836866, 2764.1707487753592, 2770.3766652503427, 2777.4583956128763, 2849.7150284971335, 944.9244060475146, 973.2894986659778, 983.3657291047234, 992.699274910924, 998.2712619787595, 19944.0, 20034.69947950782, 20270.79729202689, 20379.0, 20516.0, 1052.8052310322614, 1055.3773273768513, 1061.9787604247872, 1063.2557209953063, 1064.7018834726289, 10967.780644387067, 11273.492692828842, 11303.434828258554, 11359.602413915472, 11368.147388945863, 479090.0, 490931.0, 493518.0, 496648.0, 497525.5371169435, 108784.64861405613, 109125.0, 111336.4433177845, 111443.44278278718, 111632.0, 1170.0990237517065, 1179.504608064615, 1200.0819373179525, 1200.1119171812795, 1207.1549915059318, 17891.67408236921, 17960.730589041435, 18128.184231709867, 18306.90846545759, 18356.816431835512, 53944.73027634837, 55006.44993550013, 56020.0, 56124.0, 56544.43455565392, 69923.65038174776, 70592.6470367645, 71023.28976710167, 71071.64464177647, 71483.0, 14388.28058597087, 14699.632509187355, 14708.0, 14723.852761472248, 14968.0, 23081.192158274378, 23337.41656458602, 23349.182778603346, 23407.180748673716, 23418.297451076494, 18087.457376278733, 18372.17325220395, 18375.26498940081, 18523.536911577317, 18527.0, 15117.697646047238, 15878.285477153788, 16185.838141618433, 16765.329386824877, 16831.91584042072, 18837.434876953714, 18965.810341896406, 19055.428337149908, 19200.8079919199, 19351.322703705304, 14570.125792452487, 14591.343389547283, 14631.0, 14666.926665366605, 14689.412423503367, 18045.36841210604, 18477.260909563465, 18624.255029798656, 18635.44093677192, 18642.34751783681], "value": 12680.35568393212, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1303.1399276477523, 1374.1960952842587, 1400.362834910116, 1401.558509069643, 1408.8591140885912, 14960.625984350396, 15421.537353879401, 15473.30370133344, 15550.53348399547, 15620.2970866311, 15206.54380368588, 15277.083374997508, 15304.69390612187, 15413.614659633515, 15439.614009649764, 2691.690455597607, 2694.137875879719, 2776.986115069432, 2778.305423644089, 2785.5125353063236, 2705.8917643294244, 2718.7824974002033, 2721.9319517012136, 2723.3872378714827, 2724.359775452767, 2635.8550279734704, 2668.026170447792, 2668.3062403774966, 2669.5728683410657, 2671.3722275265295, 2582.702989156243, 2617.790576753855, 2619.7118316985116, 2619.908303209388, 2620.2401303621928, 2602.46649436865, 2602.713701492853, 2613.529564678357, 2614.6208799724122, 2615.5292047431453, 14431.927840360837, 14552.563423097325, 14674.853251467455, 14694.926525367411, 14700.70598588033, 7256.4920455568135, 7527.811804704871, 7530.209328020534, 7532.39740820733, 7544.245575442466, 4916.852494425173, 5047.2429135629945, 5206.062908676437, 5241.3710354757295, 5317.282166907496, 1896.5163883209832, 1911.5030092176135, 2332.207049603126, 2339.6256598944087, 2363.0902102690416, 26777.330566735793, 27045.864770676217, 27151.592726109124, 27169.184924452296, 27213.183604491896, 6711.429528490035, 6745.797626071226, 6849.417799487, 6920.826979325457, 6972.721091156297, 17172.570685732706, 17187.398441054753, 17242.827571724374, 17250.0, 17262.65474690499, 7802.492837965514, 7951.642176102089, 7958.363330933512, 7980.201979801974, 7984.20157984197, 7146.821329466701, 7307.671154798047, 7396.889046664304, 7446.10646722386, 7447.143578488435, 5128.410232823273, 5179.689218646818, 5198.2722418861385, 5239.580833533309, 5282.31329927107, 1502.8196616405883, 1506.412499125342, 1509.3736099518796, 1516.5374560758853, 1523.3601887207178, 901.256463417683, 916.3585490156917, 918.4994178172778, 919.6229545886155, 938.3666025432942, 7582.317591416689, 7696.384289256846, 7737.342325902361, 7790.376769858511, 7860.213978602094, 705.2876594639451, 715.1025463043846, 723.5297056912943, 730.3645828129561, 735.4153448008846, 4727.550882666142, 4845.878853028703, 5063.797448102108, 5085.923711144335, 5205.713685747321, 20034.0, 20428.489287767923, 20641.89679051625, 21136.577268454854, 21641.0, 20311.796882031285, 20324.898375508026, 20504.38486845397, 21388.465288367915, 21499.0, 9316.673916412892, 9588.0, 10085.69742907714, 11213.439328033566, 11305.660830175273, 8735.606897689491, 8994.910050899407, 9072.410293330913, 9084.18242358191, 9123.315751318545, 18237.270509180016, 18322.26710931601, 18474.261029558667, 18834.905825470785, 19194.328198512983, 19226.90386548114, 19488.61022779565, 19536.706949395488, 19885.304014359426, 19979.300724474575, 9987.051230133126, 10558.260921735406, 10558.313709609158, 10605.098566621924, 10619.840702389316, 13832.654183645489, 14060.507882224481, 14066.578002659937, 14067.859321407064, 14068.577942661737, 11253.0, 11283.0, 11332.830007549728, 11373.374464404536, 11497.137714671266, 11017.173711971474, 11144.888551114385, 11237.887621123684, 11280.661580152608, 11316.26444281119, 9966.451845148586, 10074.597016119273, 10114.797704046025, 10154.39073655583, 10161.085502304828, 7278.09023872016, 7344.48588598793, 7353.889691654523, 7371.631418429164, 7384.9261507384235, 7416.629168541659, 7456.254374562501, 7456.96271518639, 7520.398368130646, 7594.962025189839], "value": 6592.49190222265, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [496.66950662226003, 503.20857746422763, 513.8432778002709, 523.9109351410265, 526.2264471227295, 6128.509719222463, 6215.5338349623735, 6238.812835614927, 6375.234971803378, 6403.175095097898, 6300.369963003697, 6304.0, 6354.61872287663, 6363.681815909209, 6379.138816259803, 5282.894342113155, 5286.497782710637, 5301.628885977983, 5325.961437519685, 5338.439463856278, 4879.487653796354, 5073.086844368012, 5092.185250359943, 5309.787608495655, 5322.179245000137, 5026.623003274751, 5052.317937078503, 5054.039732450822, 5089.491050894918, 5090.9236361454605, 4995.200767877122, 5013.3482647255805, 5024.447310795809, 5026.8240611578785, 5034.521720436571, 4508.301213311942, 4511.6165125964335, 4523.47979982303, 4526.88682782933, 4564.954350456486, 6241.157443745082, 6255.7184926677955, 6256.562040657156, 6269.717862696144, 6271.773520400237, 5688.288963879515, 5690.971545142289, 5794.5074668653215, 5801.970990145064, 5846.269216347957, 6460.3862633049785, 6547.9345206547805, 6579.80260592183, 6589.835254118638, 6624.93375066248, 4876.536729010738, 4888.951110488921, 4894.8042078317185, 4906.31311616374, 4923.6952207665, 6853.0, 6937.0, 6939.306069393071, 6974.151849759818, 7107.573545587281, 4940.283658869444, 4988.5260900214425, 5002.874928126826, 5029.1450453423, 5035.748212589356, 5087.31321271631, 5114.3862736471865, 5121.513456221653, 5129.666571672829, 5138.2292656101135, 5698.7747634258, 5745.8563535911935, 5775.826725198251, 5778.451047150514, 5793.8841223175305, 6598.9873088707445, 6692.665366731644, 6694.765683201064, 6705.463562914955, 6710.899336509956, 1652.6861145389444, 1707.2658756734475, 1734.3236137906226, 1761.1722490429477, 1780.4213630570116, 1207.9879201207875, 1230.6185082624415, 1241.8696036916174, 1248.9812652810215, 1249.956251531192, 5708.543316534668, 5727.312722473246, 5747.195392645033, 5749.626274292157, 5799.652020878761, 6533.771318003942, 6667.499937504706, 6671.3328667133865, 6733.595984240961, 6746.359095885883, 5663.9716801415725, 5690.374058853523, 5745.569082318842, 5752.798652047242, 5803.854903627359, 3503.160840558727, 3577.4454959481322, 3599.856005759793, 3603.4774957631, 3627.9093022674115, 6441.872672282426, 6455.4835613150835, 6495.740170393131, 6497.805065848032, 6544.574602650812, 6751.966240168866, 6867.695137923779, 6893.517453778188, 6910.550814197061, 6984.860302793915, 6560.737570497126, 6579.243387010555, 6594.670266486753, 6604.273529911706, 6625.834354141089, 6767.695453704693, 6829.282925292971, 6837.153968428596, 6856.622885741132, 6863.245043045361, 6601.867962640624, 6615.04081908111, 6688.0, 6816.522843401112, 6841.657917104026, 6342.809715708536, 6471.741130354922, 6473.77341793035, 6536.8365790855605, 6582.901256481253, 4936.160852655129, 4978.2034874419915, 4985.875353116056, 5020.221865610836, 5033.471485494117, 6775.695093720893, 6785.253622101466, 6790.42281406086, 6791.592504449749, 6819.420349270169, 6367.745290188341, 6393.200849893763, 6395.16862807832, 6505.316941721051, 6529.314421985623, 6218.906716399348, 6417.39034791694, 6456.418177546531, 6491.350864913471, 6507.837304067436, 6329.620222786648, 6387.968060159856, 6406.871862562816, 6417.26201486835, 6472.449841763503, 6491.318411566906, 6536.901946470902, 6577.2436169841085, 6672.83317917056, 6680.365365290289, 6218.315985241529, 6318.368163183645, 6323.849891037069, 6358.364163583605, 6397.26431460388], "value": 5091.525181695607, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [888.0630934364248, 908.9636414543419, 916.7753900294429, 923.8752768376269, 935.9859602105968, 18980.90509547452, 19882.900585497053, 19926.90036549817, 19934.40196794097, 19953.900230498864, 17002.744958825628, 17132.229049692764, 17245.655086898256, 17287.567810804736, 17289.135543222852, 951.115462619765, 963.4508330251759, 966.3235734985539, 966.5167416291854, 966.8936416994125, 982.3860087445347, 982.8132654795565, 982.9361091529064, 983.537737263485, 983.965561205358, 983.72947439454, 1014.5535964175739, 1015.28422462164, 1017.1252722658508, 1018.7300365403174, 1008.757898104457, 1009.0313299232745, 1009.0615727373539, 1009.0666133826255, 1016.806806706727, 729.6752944939504, 736.5507040705165, 737.5943231222859, 742.0279433941554, 757.5795433534386, 17411.5647108822, 17444.91277543617, 17475.0, 17486.737698934525, 17496.91251543734, 21380.144794208212, 21728.34814955554, 21758.238461653924, 21963.670544941837, 22225.44436389103, 17631.647367052716, 17952.371666991723, 18000.90999545007, 18141.09294535268, 18143.909280453645, 3773.867914622975, 3795.6014618464937, 3799.810009499514, 3800.657940785343, 3801.8669346573015, 108450.91549084565, 142905.285473573, 146288.26855865758, 147081.0, 147563.52436475604, 17373.391931282345, 18068.548286292684, 18169.091545422674, 18263.45209643713, 18315.0, 29300.706992930223, 29892.55161172584, 29905.0, 29928.850355748084, 30046.399072018437, 9002.549872506348, 9159.404638698463, 9161.17549420542, 9311.627534898664, 9323.90676093244, 4333.43665323506, 4399.318105693623, 4415.205263052617, 4419.270820314677, 4425.668074894395, 5373.059714549938, 5400.297961265089, 5469.343678758574, 5491.148871924858, 5499.945000549943, 1097.6816723150357, 1102.32207192576, 1123.4326665034105, 1125.9493322800495, 1130.0507573638183, 702.2240424331143, 704.1409480433863, 718.3104219948907, 723.565860483716, 725.3906718356606, 11797.941010294893, 12225.755484890253, 12462.783704124759, 13269.270190139441, 13336.199828010156, 705.3510770091528, 707.0596107177441, 707.1549498349423, 715.1275443958363, 720.6901032555946, 5682.374938756733, 5764.481196692318, 5789.565782566325, 5865.970670146622, 5936.495397891142, 125950.37024814817, 127720.36139819241, 129927.0, 130968.3451582736, 133473.33263333622, 110473.44763276292, 110873.44563277133, 112905.0, 114858.42570787092, 115545.0, 97012.51493742486, 97996.0, 98928.01071989333, 100123.49938250262, 100333.0, 10749.66760304277, 10793.784124317313, 10856.294340867818, 10950.835737464104, 11202.49588768491, 44026.33960490531, 44405.55594444143, 46094.0, 46460.30309545292, 48003.27995080007, 57865.42134578769, 57890.710546447, 59076.70461647664, 59544.404555953886, 60231.397686024335, 15984.760228596348, 16323.18384080815, 16384.918075409547, 16508.587285317964, 16534.09062501526, 18091.54771130732, 18355.724664129782, 18482.907585462526, 18499.537511562317, 18536.44390668282, 15728.0, 15845.128517931624, 15848.762268566212, 15992.600184995003, 16032.759508607147, 16318.26567804428, 16460.176991150634, 16481.67036659236, 16704.665906682043, 16730.665386692443, 15874.682506349578, 16061.27724252388, 16095.356185752908, 16137.0, 16270.349186032427, 11228.214025018497, 11435.428228588371, 11612.187146899636, 11624.535018599161, 11653.475593598478, 12043.819342710041, 12132.939335303266, 12213.389330533615, 12335.753284934071, 12393.504259829866], "value": 9073.660213350826, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1430.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 107.0, 108.0, 108.0, 106.0, 109.0, 109.0, 110.0, 109.0, 109.0], "value": 108.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 117.0, 120.0, 118.0, 114.0, 148.0, 121.0, 115.0, 115.0, 119.0], "value": 121.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 162.0, 163.0, 161.0, 166.0, 165.0, 173.0, 163.0], "value": 163.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 77.0, 74.0, 74.0, 84.0, 74.0, 73.0, 74.0, 75.0, 116.0], "value": 79.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 79.0, 79.0, 79.0, 78.0, 80.0, 79.0, 81.0, 80.0, 78.0], "value": 79.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 110.0, 114.0, 115.0, 114.0, 114.0, 114.0, 115.0, 117.0], "value": 113.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 149.0, 147.0, 150.0, 151.0, 150.0, 147.0, 148.0, 149.0], "value": 148.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 93.0, 94.0, 94.0, 95.0, 96.0, 94.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 53.0, 53.0, 53.0, 53.0, 54.0, 55.0, 54.0, 52.0], "value": 53.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 38.0, 38.0, 38.0, 37.0, 38.0, 44.0, 38.0, 38.0, 38.0], "value": 38.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 75.0, 74.0, 75.0, 75.0, 78.0, 73.0, 80.0, 74.0, 78.0], "value": 77.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 111.0, 115.0, 115.0, 115.0, 113.0, 115.0, 116.0, 114.0, 113.0], "value": 114.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 165.0, 167.0, 176.0, 168.0, 170.0, 169.0, 172.0, 175.0, 174.0], "value": 170.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 66.0, 66.0, 66.0, 64.0, 66.0, 66.0, 66.0, 70.0], "value": 66.6, "unit": "score"}]}]} 23:40:05 INFO - Return code: 0 23:40:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:40:05 INFO - # TBPL SUCCESS # 23:40:05 INFO - Running post-action listener: _package_coverage_data 23:40:05 INFO - Running post-action listener: _resource_record_post_action 23:40:05 INFO - [mozharness: 2017-09-14 06:40:05.455928Z] Finished run-tests step (success) 23:40:05 INFO - Running post-run listener: _resource_record_post_run 23:40:05 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 336359424; Read time: 8; Write time: 177076 23:40:05 INFO - TinderboxPrint: CPU usage
13.1% 23:40:05 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 23:40:05 INFO - TinderboxPrint: I/O write bytes / time
336,359,424 / 177,076 23:40:05 INFO - TinderboxPrint: CPU idle
8,243.1 (86.9%) 23:40:05 INFO - TinderboxPrint: CPU user
1,194.2 (12.6%) 23:40:05 INFO - TinderboxPrint: Swap in / out
0 / 0 23:40:05 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 13164544; Read time: 0; Write time: 1480 23:40:05 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 23:40:05 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 0; Write bytes: 322834432; Read time: 0; Write time: 175572 23:40:06 INFO - Running post-run listener: _upload_blobber_files 23:40:06 INFO - Blob upload gear active. 23:40:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:40:06 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 23:40:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:40:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:40:06 INFO - (blobuploader) - INFO - Open directory for files ... 23:40:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:40:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:40:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:40:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:40:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:40:07 INFO - (blobuploader) - INFO - Done attempting. 23:40:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:40:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:40:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:40:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:40:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:40:14 INFO - (blobuploader) - INFO - Done attempting. 23:40:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 23:40:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:40:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:40:15 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 23:40:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:40:15 INFO - (blobuploader) - INFO - Done attempting. 23:40:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:40:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:40:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:40:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:40:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:40:17 INFO - (blobuploader) - INFO - Done attempting. 23:40:17 INFO - (blobuploader) - INFO - Iteration through files over. 23:40:17 INFO - Return code: 0 23:40:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:40:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:40:17 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/94f53d4babce887b83296f59d8198fe16e8efac3c278be1de11a3466ccd1b2c7891a398156a97043e06f69d0ef4ae1f5ac506c9e7b47108cbccfb62968356c2e", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7ae0eaa2e69109dd22464b8c654800a6192ab586a6da37714aa729501a188b5766ea28831e692ac95a78284c363f20850bedd35e29a1bcc2f20623871e102236", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/40904ce9210f0d5f09c917cd5e3f36a01083f025a1ce7c769d9632007229b27d570d5deac2fb06ce11ac5f4efde5798a833825bcff4234c1849d3fc90508d0fd", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e4de279c9cbe09109a72904c59ebf9ef866d8942522ca352efd6808209be80403d35768e2c84e437f49f7ba76914c99a761b8456fd6bc5c548a31fff3a0b9dde"} 23:40:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:40:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:40:17 INFO - Contents: 23:40:17 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/94f53d4babce887b83296f59d8198fe16e8efac3c278be1de11a3466ccd1b2c7891a398156a97043e06f69d0ef4ae1f5ac506c9e7b47108cbccfb62968356c2e", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7ae0eaa2e69109dd22464b8c654800a6192ab586a6da37714aa729501a188b5766ea28831e692ac95a78284c363f20850bedd35e29a1bcc2f20623871e102236", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/40904ce9210f0d5f09c917cd5e3f36a01083f025a1ce7c769d9632007229b27d570d5deac2fb06ce11ac5f4efde5798a833825bcff4234c1849d3fc90508d0fd", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e4de279c9cbe09109a72904c59ebf9ef866d8942522ca352efd6808209be80403d35768e2c84e437f49f7ba76914c99a761b8456fd6bc5c548a31fff3a0b9dde"} 23:40:17 INFO - Running post-run listener: copy_logs_to_upload_dir 23:40:17 INFO - Copying logs to upload dir... 23:40:17 INFO - mkdir: /builds/slave/test/build/upload/logs 23:40:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.542198 ========= master_lag: 0.10 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2017-09-13 23:40:17.093764) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-13 23:40:17.097550) ========= 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=41a7e32711b8e08598a63237000001d6-1505362313.990101-395763722 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/94f53d4babce887b83296f59d8198fe16e8efac3c278be1de11a3466ccd1b2c7891a398156a97043e06f69d0ef4ae1f5ac506c9e7b47108cbccfb62968356c2e", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7ae0eaa2e69109dd22464b8c654800a6192ab586a6da37714aa729501a188b5766ea28831e692ac95a78284c363f20850bedd35e29a1bcc2f20623871e102236", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/40904ce9210f0d5f09c917cd5e3f36a01083f025a1ce7c769d9632007229b27d570d5deac2fb06ce11ac5f4efde5798a833825bcff4234c1849d3fc90508d0fd", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e4de279c9cbe09109a72904c59ebf9ef866d8942522ca352efd6808209be80403d35768e2c84e437f49f7ba76914c99a761b8456fd6bc5c548a31fff3a0b9dde"} build_url:https://queue.taskcluster.net/v1/task/Zv5HYUSPS56G-8wZXuIJvw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011293 build_url: 'https://queue.taskcluster.net/v1/task/Zv5HYUSPS56G-8wZXuIJvw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/94f53d4babce887b83296f59d8198fe16e8efac3c278be1de11a3466ccd1b2c7891a398156a97043e06f69d0ef4ae1f5ac506c9e7b47108cbccfb62968356c2e", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7ae0eaa2e69109dd22464b8c654800a6192ab586a6da37714aa729501a188b5766ea28831e692ac95a78284c363f20850bedd35e29a1bcc2f20623871e102236", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/40904ce9210f0d5f09c917cd5e3f36a01083f025a1ce7c769d9632007229b27d570d5deac2fb06ce11ac5f4efde5798a833825bcff4234c1849d3fc90508d0fd", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e4de279c9cbe09109a72904c59ebf9ef866d8942522ca352efd6808209be80403d35768e2c84e437f49f7ba76914c99a761b8456fd6bc5c548a31fff3a0b9dde"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-13 23:40:17.125338) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 23:40:17.125644) ========= 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=41a7e32711b8e08598a63237000001d6-1505362313.990101-395763722 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004417 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 23:40:17.212197) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-13 23:40:17.212561) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-13 23:40:17.212908) ========= ========= Total master_lag: 0.27 =========