builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-071 starttime: 1505759070.48 results: success (0) revision: 42151fcd6cfc216d147730d0f2c6a2acd52d22fd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-18 11:24:30.483241) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-18 11:24:30.483716) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-18 11:24:30.484352) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-18 11:24:30.554441) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 11:24:30.554752) ========= 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=dbb0bb31bf4a4c7db9ba1648000001b6-1505753956.465478-1105325866 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-18 11:24:30-- 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% 225M=0s 2017-09-18 11:24:30 (225 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.094826 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 11:24:30.683044) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 11:24:30.683388) ========= 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=dbb0bb31bf4a4c7db9ba1648000001b6-1505753956.465478-1105325866 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018503 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 11:24:30.749042) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 11:24:30.749342) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 42151fcd6cfc216d147730d0f2c6a2acd52d22fd --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 42151fcd6cfc216d147730d0f2c6a2acd52d22fd --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=dbb0bb31bf4a4c7db9ba1648000001b6-1505753956.465478-1105325866 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-18 11:24:30,805 truncating revision to first 12 chars 2017-09-18 11:24:30,805 Setting DEBUG logging. 2017-09-18 11:24:30,805 attempt 1/10 2017-09-18 11:24:30,806 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/42151fcd6cfc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-18 11:24:31,110 unpacking tar archive at: mozilla-central-42151fcd6cfc/testing/mozharness/ program finished with exit code 0 elapsedTime=0.585560 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 11:24:31.354376) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-18 11:24:31.354675) ========= script_repo_revision: 42151fcd6cfc216d147730d0f2c6a2acd52d22fd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-18 11:24:31.355052) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-18 11:24:31.355337) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-18 11:24:31.367750) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2017-09-18 11:24:31.368063) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=dbb0bb31bf4a4c7db9ba1648000001b6-1505753956.465478-1105325866 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:24:31 INFO - MultiFileLogger online at 20170918 11:24:31 in /builds/slave/test 11:24:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 11:24:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:24:31 INFO - {'append_to_log': False, 11:24:31 INFO - 'base_work_dir': '/builds/slave/test', 11:24:31 INFO - 'blob_upload_branch': 'Firefox', 11:24:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:24:31 INFO - 'branch': 'Firefox', 11:24:31 INFO - 'buildbot_json_path': 'buildprops.json', 11:24:31 INFO - 'code_coverage': False, 11:24:31 INFO - 'config_files': ('talos/linux_config.py',), 11:24:31 INFO - 'default_actions': ('clobber', 11:24:31 INFO - 'read-buildbot-config', 11:24:31 INFO - 'download-and-extract', 11:24:31 INFO - 'populate-webroot', 11:24:31 INFO - 'create-virtualenv', 11:24:31 INFO - 'install', 11:24:31 INFO - 'setup-mitmproxy', 11:24:31 INFO - 'run-tests'), 11:24:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:24:31 INFO - 'disable_ccov_upload': False, 11:24:31 INFO - 'disable_stylo': False, 11:24:31 INFO - 'download_minidump_stackwalk': True, 11:24:31 INFO - 'download_symbols': 'ondemand', 11:24:31 INFO - 'enable_stylo': False, 11:24:31 INFO - 'enable_webrender': False, 11:24:31 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 11:24:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:24:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:24:31 INFO - 'gecko_profile': False, 11:24:31 INFO - 'gecko_profile_interval': 0, 11:24:31 INFO - 'installer_path': 'installer.exe', 11:24:31 INFO - 'log_level': 'info', 11:24:31 INFO - 'log_name': 'talos', 11:24:31 INFO - 'log_to_console': True, 11:24:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:24:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:24:31 INFO - 'opt_config_files': (), 11:24:31 INFO - 'pip_index': False, 11:24:31 INFO - 'suite': 'dromaeojs-e10s', 11:24:31 INFO - 'system_bits': '32', 11:24:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:24:31 INFO - 'title': 'talos-linux64-ix-071', 11:24:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:24:31 INFO - 'use_talos_json': True, 11:24:31 INFO - 'verify': 'False', 11:24:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:24:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:24:31 INFO - 'work_dir': 'build'} 11:24:31 INFO - [mozharness: 2017-09-18 18:24:31.565732Z] Running clobber step. 11:24:31 INFO - Running pre-action listener: _resource_record_pre_action 11:24:31 INFO - Running main action method: clobber 11:24:31 INFO - rmtree: /builds/slave/test/build 11:24:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:24:32 INFO - Running post-action listener: _resource_record_post_action 11:24:32 INFO - [mozharness: 2017-09-18 18:24:32.573631Z] Finished clobber step (success) 11:24:32 INFO - [mozharness: 2017-09-18 18:24:32.573727Z] Running read-buildbot-config step. 11:24:32 INFO - Running pre-action listener: _resource_record_pre_action 11:24:32 INFO - Running main action method: read_buildbot_config 11:24:32 INFO - Using buildbot properties: 11:24:32 INFO - { 11:24:32 INFO - "project": "", 11:24:32 INFO - "product": "firefox", 11:24:32 INFO - "who": "ffxbld@noreply.mozilla.org", 11:24:32 INFO - "installer_path": "public/build/target.tar.bz2", 11:24:32 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 11:24:32 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:24:32 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 11:24:32 INFO - "stage_platform": "linux64-qr", 11:24:32 INFO - "basedir": "/builds/slave/test", 11:24:32 INFO - "buildnumber": 64, 11:24:32 INFO - "platform": "ubuntu64_hw_qr", 11:24:32 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:24:32 INFO - "slavebuilddir": "test", 11:24:32 INFO - "taskId": "PCaBb-itSEuRk-JGv7ZCPg", 11:24:32 INFO - "branch": "mozilla-central", 11:24:32 INFO - "script_repo_revision": "production", 11:24:32 INFO - "revision": "42151fcd6cfc216d147730d0f2c6a2acd52d22fd", 11:24:32 INFO - "slavename": "talos-linux64-ix-071", 11:24:32 INFO - "repo_path": "mozilla-central" 11:24:32 INFO - } 11:24:32 INFO - Finding installer, test and symbols from parent task. 11:24:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PCaBb-itSEuRk-JGv7ZCPg'}, attempt #1 11:24:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PCaBb-itSEuRk-JGv7ZCPg'}, attempt #1 11:24:33 INFO - Task dependencies: SnPiQaAJQmqSN7jo34Jbdw 11:24:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SnPiQaAJQmqSN7jo34Jbdw'}, attempt #1 11:24:34 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/SnPiQaAJQmqSN7jo34Jbdw/artifacts/public/build/target.tar.bz2 11:24:34 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/SnPiQaAJQmqSN7jo34Jbdw/artifacts/public/build/target.test_packages.json 11:24:34 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/SnPiQaAJQmqSN7jo34Jbdw/artifacts/public/build/target.crashreporter-symbols.zip 11:24:34 INFO - Running post-action listener: _resource_record_post_action 11:24:34 INFO - [mozharness: 2017-09-18 18:24:34.053552Z] Finished read-buildbot-config step (success) 11:24:34 INFO - [mozharness: 2017-09-18 18:24:34.053767Z] Running download-and-extract step. 11:24:34 INFO - Running pre-action listener: _resource_record_pre_action 11:24:34 INFO - Running main action method: download_and_extract 11:24:34 INFO - mkdir: /builds/slave/test/build/tests 11:24:34 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')]} 11:24:34 INFO - trying https://queue.taskcluster.net/v1/task/SnPiQaAJQmqSN7jo34Jbdw/artifacts/public/build/target.test_packages.json 11:24:34 INFO - Downloading https://queue.taskcluster.net/v1/task/SnPiQaAJQmqSN7jo34Jbdw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:24:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SnPiQaAJQmqSN7jo34Jbdw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:24:34 INFO - Downloaded 989 bytes. 11:24:34 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:24:34 INFO - Using the following test package requirements: 11:24:34 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:24:34 INFO - u'common': [u'target.common.tests.zip'], 11:24:34 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:24:34 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:24:34 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:24:34 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:24:34 INFO - u'mozbase': [u'target.common.tests.zip'], 11:24:34 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:24:34 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:24:34 INFO - u'web-platform': [u'target.common.tests.zip', 11:24:34 INFO - u'target.web-platform.tests.tar.gz'], 11:24:34 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:24:34 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 11:24:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SnPiQaAJQmqSN7jo34Jbdw/artifacts/public/build/target.common.tests.zip 11:24:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SnPiQaAJQmqSN7jo34Jbdw/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:24:34 INFO - Fetch https://queue.taskcluster.net/v1/task/SnPiQaAJQmqSN7jo34Jbdw/artifacts/public/build/target.common.tests.zip into memory 11:24:35 INFO - Content-Length response header: 54731144 11:24:35 INFO - Bytes received: 54731144 11:24:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SnPiQaAJQmqSN7jo34Jbdw/artifacts/public/build/target.talos.tests.zip 11:24:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SnPiQaAJQmqSN7jo34Jbdw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:24:46 INFO - Fetch https://queue.taskcluster.net/v1/task/SnPiQaAJQmqSN7jo34Jbdw/artifacts/public/build/target.talos.tests.zip into memory 11:24:47 INFO - Content-Length response header: 14508748 11:24:47 INFO - Bytes received: 14508748 11:24:47 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')]} 11:24:47 INFO - trying https://queue.taskcluster.net/v1/task/SnPiQaAJQmqSN7jo34Jbdw/artifacts/public/build/target.tar.bz2 11:24:47 INFO - Downloading https://queue.taskcluster.net/v1/task/SnPiQaAJQmqSN7jo34Jbdw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:24:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SnPiQaAJQmqSN7jo34Jbdw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:24:48 INFO - Downloaded 61505247 bytes. 11:24:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SnPiQaAJQmqSN7jo34Jbdw/artifacts/public/build/target.tar.bz2 11:24:48 INFO - mkdir: /builds/slave/test/properties 11:24:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:24:48 INFO - Writing to file /builds/slave/test/properties/build_url 11:24:48 INFO - Contents: 11:24:48 INFO - build_url:https://queue.taskcluster.net/v1/task/SnPiQaAJQmqSN7jo34Jbdw/artifacts/public/build/target.tar.bz2 11:24:48 INFO - Running post-action listener: _resource_record_post_action 11:24:48 INFO - Running post-action listener: find_tests_for_verification 11:24:48 INFO - Running post-action listener: set_extra_try_arguments 11:24:48 INFO - [mozharness: 2017-09-18 18:24:48.705742Z] Finished download-and-extract step (success) 11:24:48 INFO - [mozharness: 2017-09-18 18:24:48.705839Z] Running populate-webroot step. 11:24:48 INFO - Running pre-action listener: _resource_record_pre_action 11:24:48 INFO - Running main action method: populate_webroot 11:24:48 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:24:48 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:24:48 INFO - 'tests': ['tresize', 11:24:48 INFO - 'tcanvasmark']}, 11:24:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:24:48 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:24:48 INFO - 'tests': ['dromaeo_css', 11:24:48 INFO - 'kraken']}, 11:24:48 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:24:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:24:48 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:24:48 INFO - 'talos_options': ['--disable-stylo'], 11:24:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:24:48 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:24:48 INFO - 'tests': ['damp', 'tps']}, 11:24:48 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:24:48 INFO - 'talos_options': ['--disable-stylo'], 11:24:48 INFO - 'tests': ['damp', 'tps']}, 11:24:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:24:48 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:24:48 INFO - 'tests': ['dromaeo_dom']}, 11:24:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:24:48 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:24:48 INFO - 'tests': ['basic_compositor_video', 11:24:48 INFO - 'glvideo']}, 11:24:48 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:24:48 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:24:48 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:24:48 INFO - 'talos_options': ['--disable-stylo'], 11:24:48 INFO - 'tests': ['ts_paint_webext', 11:24:48 INFO - 'tp5o_webext']}, 11:24:48 INFO - 'other-e10s': {'tests': ['a11yr', 11:24:48 INFO - 'ts_paint', 11:24:48 INFO - 'tpaint', 11:24:48 INFO - 'sessionrestore', 11:24:48 INFO - 'sessionrestore_many_windows', 11:24:48 INFO - 'sessionrestore_no_auto_restore', 11:24:48 INFO - 'tabpaint']}, 11:24:48 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:24:48 INFO - 'tests': ['a11yr', 11:24:48 INFO - 'ts_paint', 11:24:48 INFO - 'tpaint', 11:24:48 INFO - 'sessionrestore', 11:24:48 INFO - 'sessionrestore_many_windows', 11:24:48 INFO - 'sessionrestore_no_auto_restore', 11:24:48 INFO - 'tabpaint']}, 11:24:48 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 11:24:48 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 11:24:48 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:24:48 INFO - 'tests': ['perf_reftest_singletons']}, 11:24:48 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:24:48 INFO - 'tests': ['bloom_basic']}, 11:24:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:24:48 INFO - 'tsvgr_opacity', 11:24:48 INFO - 'tart', 11:24:48 INFO - 'tscrollx', 11:24:48 INFO - 'tsvg_static']}, 11:24:48 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:24:48 INFO - 'tests': ['tsvgx', 11:24:48 INFO - 'tsvgr_opacity', 11:24:48 INFO - 'tart', 11:24:48 INFO - 'tscrollx', 11:24:48 INFO - 'tsvg_static']}, 11:24:48 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:24:48 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:24:48 INFO - 'talos_options': ['--disable-stylo'], 11:24:48 INFO - 'tests': ['tp5o']}, 11:24:48 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:24:48 INFO - 'talos_options': ['--mitmproxy', 11:24:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:24:48 INFO - '--firstNonBlankPaint'], 11:24:48 INFO - 'tests': ['tp6_google', 11:24:48 INFO - 'tp6_youtube', 11:24:48 INFO - 'tp6_amazon', 11:24:48 INFO - 'tp6_facebook']}, 11:24:48 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:24:48 INFO - 'talos_options': ['--disable-stylo', 11:24:48 INFO - '--mitmproxy', 11:24:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:24:48 INFO - '--firstNonBlankPaint'], 11:24:48 INFO - 'tests': ['tp6_google', 11:24:48 INFO - 'tp6_youtube', 11:24:48 INFO - 'tp6_amazon', 11:24:48 INFO - 'tp6_facebook']}, 11:24:48 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:24:48 INFO - 'talos_options': ['--stylo-threads=1', 11:24:48 INFO - '--mitmproxy', 11:24:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:24:48 INFO - '--firstNonBlankPaint'], 11:24:48 INFO - 'tests': ['tp6_google', 11:24:48 INFO - 'tp6_youtube', 11:24:48 INFO - 'tp6_amazon', 11:24:48 INFO - 'tp6_facebook']}, 11:24:48 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:24:48 INFO - 'talos_options': ['--xperf_path', 11:24:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:24:48 INFO - 'tests': ['tp5n']}, 11:24:48 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:24:48 INFO - 'talos_options': ['--disable-stylo', 11:24:48 INFO - '--xperf_path', 11:24:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:24:48 INFO - 'tests': ['tp5n']}}} 11:24:48 INFO - Running post-action listener: _resource_record_post_action 11:24:48 INFO - [mozharness: 2017-09-18 18:24:48.720592Z] Finished populate-webroot step (success) 11:24:48 INFO - [mozharness: 2017-09-18 18:24:48.720681Z] Running create-virtualenv step. 11:24:48 INFO - Running pre-action listener: _resource_record_pre_action 11:24:48 INFO - Running main action method: create_virtualenv 11:24:48 INFO - Creating virtualenv /builds/slave/test/build/venv 11:24:48 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:24:48 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 11:24:48 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:24:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:24:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:24:49 INFO - Installing distribute.............................................................................................................................................................................................done. 11:24:49 INFO - Installing pip...............done. 11:24:49 INFO - Return code: 0 11:24:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:24:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:24:49 INFO - Reading from file tmpfile_stdout 11:24:49 INFO - Output received: 11:24:49 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 11:24:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:24:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:49 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 0x1d001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x206ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2070090>, '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 0x2070d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x206af90>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1505753956.465478-1105325866', '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 11:24:49 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 11:24:49 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 11:24:49 INFO - Using env: {'DISPLAY': ':0', 11:24:49 INFO - 'HOME': '/home/cltbld', 11:24:49 INFO - 'LANG': 'en_US.UTF-8', 11:24:49 INFO - 'LANGUAGE': 'en_US:en', 11:24:49 INFO - 'LOGNAME': 'cltbld', 11:24:49 INFO - 'MAIL': '/var/mail/cltbld', 11:24:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:49 INFO - 'MOZ_NO_REMOTE': '1', 11:24:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:49 INFO - 'NO_EM_RESTART': '1', 11:24:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:49 INFO - 'PWD': '/builds/slave/test', 11:24:49 INFO - 'SHELL': '/bin/bash', 11:24:49 INFO - 'SHLVL': '1', 11:24:49 INFO - 'TERM': 'linux', 11:24:49 INFO - 'TMOUT': '86400', 11:24:49 INFO - 'USER': 'cltbld', 11:24:49 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1505753956.465478-1105325866', 11:24:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:49 INFO - '_': '/tools/buildbot/bin/python'} 11:24:50 INFO - Ignoring indexes: http://pypi.python.org/simple/ 11:24:50 INFO - Downloading/unpacking pip>=1.5 11:24:50 INFO - Running setup.py egg_info for package pip 11:24:50 INFO - warning: no files found matching 'pip/cacert.pem' 11:24:50 INFO - warning: no files found matching '*.html' under directory 'docs' 11:24:50 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:24:50 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:24:50 INFO - Installing collected packages: pip 11:24:50 INFO - Found existing installation: pip 1.1 11:24:50 INFO - Uninstalling pip: 11:24:50 INFO - Successfully uninstalled pip 11:24:50 INFO - Running setup.py install for pip 11:24:50 INFO - warning: no files found matching 'pip/cacert.pem' 11:24:50 INFO - warning: no files found matching '*.html' under directory 'docs' 11:24:50 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:24:50 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:24:50 INFO - Installing pip script to /builds/slave/test/build/venv/bin 11:24:50 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 11:24:50 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 11:24:50 INFO - Successfully installed pip 11:24:50 INFO - Cleaning up... 11:24:50 INFO - Return code: 0 11:24:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:24: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')]} 11:24:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24: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')]} 11:24:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1d001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x206ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2070090>, '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 0x2070d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x206af90>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1505753956.465478-1105325866', '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 11:24:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:24:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:24:50 INFO - Using env: {'DISPLAY': ':0', 11:24:50 INFO - 'HOME': '/home/cltbld', 11:24:50 INFO - 'LANG': 'en_US.UTF-8', 11:24:50 INFO - 'LANGUAGE': 'en_US:en', 11:24:50 INFO - 'LOGNAME': 'cltbld', 11:24:50 INFO - 'MAIL': '/var/mail/cltbld', 11:24:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:50 INFO - 'MOZ_NO_REMOTE': '1', 11:24:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:50 INFO - 'NO_EM_RESTART': '1', 11:24:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:50 INFO - 'PWD': '/builds/slave/test', 11:24:50 INFO - 'SHELL': '/bin/bash', 11:24:50 INFO - 'SHLVL': '1', 11:24:50 INFO - 'TERM': 'linux', 11:24:50 INFO - 'TMOUT': '86400', 11:24:50 INFO - 'USER': 'cltbld', 11:24:50 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1505753956.465478-1105325866', 11:24:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:50 INFO - '_': '/tools/buildbot/bin/python'} 11:24:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:51 INFO - Downloading/unpacking psutil>=3.1.1 11:24:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:24:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:24:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:24:52 INFO - Installing collected packages: psutil 11:24:52 INFO - Running setup.py install for psutil 11:24:52 INFO - building 'psutil._psutil_linux' extension 11:24:52 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 11:24:52 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 11:24:52 INFO - building 'psutil._psutil_posix' extension 11:24:52 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 11:24:52 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 11:24:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:24:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:24:52 INFO - Successfully installed psutil 11:24:52 INFO - Cleaning up... 11:24:52 INFO - Return code: 0 11:24:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:24:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:52 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 0x1d001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x206ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2070090>, '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 0x2070d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x206af90>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1505753956.465478-1105325866', '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 11:24:52 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 11:24:52 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 11:24:52 INFO - Using env: {'DISPLAY': ':0', 11:24:52 INFO - 'HOME': '/home/cltbld', 11:24:52 INFO - 'LANG': 'en_US.UTF-8', 11:24:52 INFO - 'LANGUAGE': 'en_US:en', 11:24:52 INFO - 'LOGNAME': 'cltbld', 11:24:52 INFO - 'MAIL': '/var/mail/cltbld', 11:24:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:52 INFO - 'MOZ_NO_REMOTE': '1', 11:24:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:52 INFO - 'NO_EM_RESTART': '1', 11:24:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:52 INFO - 'PWD': '/builds/slave/test', 11:24:52 INFO - 'SHELL': '/bin/bash', 11:24:52 INFO - 'SHLVL': '1', 11:24:52 INFO - 'TERM': 'linux', 11:24:52 INFO - 'TMOUT': '86400', 11:24:52 INFO - 'USER': 'cltbld', 11:24:52 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1505753956.465478-1105325866', 11:24:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:52 INFO - '_': '/tools/buildbot/bin/python'} 11:24:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:24:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:24:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:24:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:24:54 INFO - Installing collected packages: mozsystemmonitor 11:24:54 INFO - Running setup.py install for mozsystemmonitor 11:24:54 INFO - Successfully installed mozsystemmonitor 11:24:54 INFO - Cleaning up... 11:24:55 INFO - Return code: 0 11:24:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:24:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x206ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2070090>, '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 0x2070d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x206af90>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1505753956.465478-1105325866', '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 11:24:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:24:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:24:55 INFO - Using env: {'DISPLAY': ':0', 11:24:55 INFO - 'HOME': '/home/cltbld', 11:24:55 INFO - 'LANG': 'en_US.UTF-8', 11:24:55 INFO - 'LANGUAGE': 'en_US:en', 11:24:55 INFO - 'LOGNAME': 'cltbld', 11:24:55 INFO - 'MAIL': '/var/mail/cltbld', 11:24:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:55 INFO - 'MOZ_NO_REMOTE': '1', 11:24:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:55 INFO - 'NO_EM_RESTART': '1', 11:24:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:55 INFO - 'PWD': '/builds/slave/test', 11:24:55 INFO - 'SHELL': '/bin/bash', 11:24:55 INFO - 'SHLVL': '1', 11:24:55 INFO - 'TERM': 'linux', 11:24:55 INFO - 'TMOUT': '86400', 11:24:55 INFO - 'USER': 'cltbld', 11:24:55 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1505753956.465478-1105325866', 11:24:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:55 INFO - '_': '/tools/buildbot/bin/python'} 11:24:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:55 INFO - Downloading/unpacking jsonschema==2.5.1 11:24:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:24:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:24:57 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 11:24:57 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 11:24:57 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 11:24:57 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 11:24:57 INFO - Downloading functools32-3.2.3-2.tar.gz 11:24:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:24:57 INFO - warning: no files found matching '*.txt' 11:24:57 INFO - no previously-included directories found matching 'build' 11:24:57 INFO - no previously-included directories found matching 'dist' 11:24:57 INFO - no previously-included directories found matching '.git*' 11:24:57 INFO - Installing collected packages: jsonschema, functools32 11:24:57 INFO - Running setup.py install for functools32 11:24:57 INFO - warning: no files found matching '*.txt' 11:24:57 INFO - no previously-included directories found matching 'build' 11:24:57 INFO - no previously-included directories found matching 'dist' 11:24:57 INFO - no previously-included directories found matching '.git*' 11:24:57 INFO - Successfully installed jsonschema functools32 11:24:57 INFO - Cleaning up... 11:24:57 INFO - Return code: 0 11:24:57 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:24:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1d001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x206ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2070090>, '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 0x2070d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x206af90>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1505753956.465478-1105325866', '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 11:24:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:24:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:24:57 INFO - Using env: {'DISPLAY': ':0', 11:24:57 INFO - 'HOME': '/home/cltbld', 11:24:57 INFO - 'LANG': 'en_US.UTF-8', 11:24:57 INFO - 'LANGUAGE': 'en_US:en', 11:24:57 INFO - 'LOGNAME': 'cltbld', 11:24:57 INFO - 'MAIL': '/var/mail/cltbld', 11:24:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:57 INFO - 'MOZ_NO_REMOTE': '1', 11:24:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:57 INFO - 'NO_EM_RESTART': '1', 11:24:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:57 INFO - 'PWD': '/builds/slave/test', 11:24:57 INFO - 'SHELL': '/bin/bash', 11:24:57 INFO - 'SHLVL': '1', 11:24:57 INFO - 'TERM': 'linux', 11:24:57 INFO - 'TMOUT': '86400', 11:24:57 INFO - 'USER': 'cltbld', 11:24:57 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1505753956.465478-1105325866', 11:24:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:57 INFO - '_': '/tools/buildbot/bin/python'} 11:24:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:58 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:24:58 INFO - Cleaning up... 11:24:58 INFO - Return code: 0 11:24:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:24:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1d001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x206ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2070090>, '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 0x2070d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x206af90>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1505753956.465478-1105325866', '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 11:24:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:24:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:24:58 INFO - Using env: {'DISPLAY': ':0', 11:24:58 INFO - 'HOME': '/home/cltbld', 11:24:58 INFO - 'LANG': 'en_US.UTF-8', 11:24:58 INFO - 'LANGUAGE': 'en_US:en', 11:24:58 INFO - 'LOGNAME': 'cltbld', 11:24:58 INFO - 'MAIL': '/var/mail/cltbld', 11:24:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:58 INFO - 'MOZ_NO_REMOTE': '1', 11:24:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:58 INFO - 'NO_EM_RESTART': '1', 11:24:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:58 INFO - 'PWD': '/builds/slave/test', 11:24:58 INFO - 'SHELL': '/bin/bash', 11:24:58 INFO - 'SHLVL': '1', 11:24:58 INFO - 'TERM': 'linux', 11:24:58 INFO - 'TMOUT': '86400', 11:24:58 INFO - 'USER': 'cltbld', 11:24:58 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1505753956.465478-1105325866', 11:24:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:58 INFO - '_': '/tools/buildbot/bin/python'} 11:24:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:58 INFO - Downloading/unpacking blobuploader==1.2.4 11:24:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:59 INFO - Downloading blobuploader-1.2.4.tar.gz 11:24:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:24:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:24:59 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 11:24:59 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 11:24:59 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 11:24:59 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 11:24:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:24:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:24:59 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 11:24:59 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 11:24:59 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 11:24:59 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 11:24:59 INFO - Downloading docopt-0.6.1.tar.gz 11:24:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:24:59 INFO - Installing collected packages: blobuploader, requests, docopt 11:24:59 INFO - Running setup.py install for blobuploader 11:25:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:25:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:25:00 INFO - Running setup.py install for requests 11:25:00 INFO - Running setup.py install for docopt 11:25:00 INFO - Successfully installed blobuploader requests docopt 11:25:00 INFO - Cleaning up... 11:25:00 INFO - Return code: 0 11:25:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:25: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')]} 11:25:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25: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')]} 11:25:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:00 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 0x1d001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x206ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2070090>, '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 0x2070d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x206af90>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1505753956.465478-1105325866', '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 11:25:00 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 11:25:00 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 11:25:00 INFO - Using env: {'DISPLAY': ':0', 11:25:00 INFO - 'HOME': '/home/cltbld', 11:25:00 INFO - 'LANG': 'en_US.UTF-8', 11:25:00 INFO - 'LANGUAGE': 'en_US:en', 11:25:00 INFO - 'LOGNAME': 'cltbld', 11:25:00 INFO - 'MAIL': '/var/mail/cltbld', 11:25:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:00 INFO - 'MOZ_NO_REMOTE': '1', 11:25:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:00 INFO - 'NO_EM_RESTART': '1', 11:25:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:00 INFO - 'PWD': '/builds/slave/test', 11:25:00 INFO - 'SHELL': '/bin/bash', 11:25:00 INFO - 'SHLVL': '1', 11:25:00 INFO - 'TERM': 'linux', 11:25:00 INFO - 'TMOUT': '86400', 11:25:00 INFO - 'USER': 'cltbld', 11:25:00 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1505753956.465478-1105325866', 11:25:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:00 INFO - '_': '/tools/buildbot/bin/python'} 11:25:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:25:00 INFO - Running setup.py (path:/tmp/pip-QziGun-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:25:00 INFO - Running setup.py (path:/tmp/pip-9xA1Pq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:25:00 INFO - Running setup.py (path:/tmp/pip-zUmDP7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:25:00 INFO - Running setup.py (path:/tmp/pip-9GLLTF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:25:01 INFO - Running setup.py (path:/tmp/pip-ttg3VT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:25:01 INFO - Running setup.py (path:/tmp/pip-XyYIHV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:25:01 INFO - Running setup.py (path:/tmp/pip-gfTy6R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:25:01 INFO - Running setup.py (path:/tmp/pip-ihT1fQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:25:01 INFO - Running setup.py (path:/tmp/pip-BWpShP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:25:01 INFO - Running setup.py (path:/tmp/pip-nluH7J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:25:01 INFO - Running setup.py (path:/tmp/pip-cOLC2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:25:01 INFO - Running setup.py (path:/tmp/pip-fuo7I1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:25:01 INFO - Running setup.py (path:/tmp/pip-Q1A0wu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:25:01 INFO - Running setup.py (path:/tmp/pip-3hDh5T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:25:01 INFO - Running setup.py (path:/tmp/pip-A7bqy2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:25:01 INFO - Running setup.py (path:/tmp/pip-Q8VDcd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:25:01 INFO - Running setup.py (path:/tmp/pip-auc2rr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:25:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:25:01 INFO - Running setup.py install for manifestparser 11:25:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:25:02 INFO - Running setup.py install for mozcrash 11:25:02 INFO - Running setup.py install for mozdebug 11:25:02 INFO - Running setup.py install for mozdevice 11:25:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:25:02 INFO - Running setup.py install for mozfile 11:25:02 INFO - Running setup.py install for mozhttpd 11:25:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:25:02 INFO - Running setup.py install for mozinfo 11:25:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:25:02 INFO - Running setup.py install for mozInstall 11:25:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:25:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:25:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:25:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:25:02 INFO - Running setup.py install for mozleak 11:25:02 INFO - Running setup.py install for mozlog 11:25:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:25:02 INFO - Running setup.py install for moznetwork 11:25:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:25:03 INFO - Running setup.py install for mozprocess 11:25:03 INFO - Running setup.py install for mozprofile 11:25:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:25:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:25:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:25:03 INFO - Running setup.py install for mozrunner 11:25:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:25:03 INFO - Running setup.py install for mozscreenshot 11:25:03 INFO - Running setup.py install for moztest 11:25:03 INFO - Running setup.py install for mozversion 11:25:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:25:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:25:03 INFO - Cleaning up... 11:25:03 INFO - Return code: 0 11:25:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:25: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')]} 11:25:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25: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')]} 11:25:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:03 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 0x1d001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x206ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2070090>, '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 0x2070d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x206af90>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1505753956.465478-1105325866', '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 11:25:03 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 11:25:03 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 11:25:03 INFO - Using env: {'DISPLAY': ':0', 11:25:03 INFO - 'HOME': '/home/cltbld', 11:25:03 INFO - 'LANG': 'en_US.UTF-8', 11:25:03 INFO - 'LANGUAGE': 'en_US:en', 11:25:03 INFO - 'LOGNAME': 'cltbld', 11:25:03 INFO - 'MAIL': '/var/mail/cltbld', 11:25:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:03 INFO - 'MOZ_NO_REMOTE': '1', 11:25:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:03 INFO - 'NO_EM_RESTART': '1', 11:25:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:03 INFO - 'PWD': '/builds/slave/test', 11:25:03 INFO - 'SHELL': '/bin/bash', 11:25:03 INFO - 'SHLVL': '1', 11:25:03 INFO - 'TERM': 'linux', 11:25:03 INFO - 'TMOUT': '86400', 11:25:03 INFO - 'USER': 'cltbld', 11:25:03 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1505753956.465478-1105325866', 11:25:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:03 INFO - '_': '/tools/buildbot/bin/python'} 11:25:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:25:03 INFO - Running setup.py (path:/tmp/pip-KaanZw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:25:03 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)) 11:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:25:04 INFO - Running setup.py (path:/tmp/pip-jXkw3y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:25:04 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)) 11:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:25:04 INFO - Running setup.py (path:/tmp/pip-ZpQYoR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:25:04 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)) 11:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:25:04 INFO - Running setup.py (path:/tmp/pip-Ea5Opp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:25:04 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)) 11:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:25:04 INFO - Running setup.py (path:/tmp/pip-QW3fNV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:25:04 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)) 11:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:25:04 INFO - Running setup.py (path:/tmp/pip-957c4M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:25:04 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)) 11:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:25:04 INFO - Running setup.py (path:/tmp/pip-bR7SrK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:25:04 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)) 11:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:25:04 INFO - Running setup.py (path:/tmp/pip-cHesKr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:25:04 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)) 11:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:25:04 INFO - Running setup.py (path:/tmp/pip-7PnVsA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:25:04 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)) 11:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:25:04 INFO - Running setup.py (path:/tmp/pip-Nn9Xun-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:25:04 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)) 11:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:25:04 INFO - Running setup.py (path:/tmp/pip-KrLFPL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:25:04 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)) 11:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:25:04 INFO - Running setup.py (path:/tmp/pip-SpCtbA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:25:04 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)) 11:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:25:04 INFO - Running setup.py (path:/tmp/pip-HoYeDV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:25:04 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)) 11:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:25:04 INFO - Running setup.py (path:/tmp/pip-khbjdQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:25:04 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)) 11:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:25:04 INFO - Running setup.py (path:/tmp/pip-0nRNjY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:25:05 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)) 11:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:25:05 INFO - Running setup.py (path:/tmp/pip-KKg7FU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:25:05 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)) 11:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:25:05 INFO - Running setup.py (path:/tmp/pip-LlkFcY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:25:05 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)) 11:25:05 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)) 11:25:05 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)) 11:25:05 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)) 11:25:05 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)) 11:25:05 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)) 11:25:05 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)) 11:25:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:25: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 11:25: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 11:25: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 11:25: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 11:25:06 INFO - Downloading blessings-1.6.tar.gz 11:25:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:25:06 INFO - Installing collected packages: blessings 11:25:06 INFO - Running setup.py install for blessings 11:25:06 INFO - Successfully installed blessings 11:25:06 INFO - Cleaning up... 11:25:06 INFO - Return code: 0 11:25:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:25:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:25:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:25:06 INFO - Reading from file tmpfile_stdout 11:25:06 INFO - Current package versions: 11:25:06 INFO - argparse == 1.2.1 11:25:06 INFO - blessings == 1.6 11:25:06 INFO - blobuploader == 1.2.4 11:25:06 INFO - docopt == 0.6.1 11:25:06 INFO - functools32 == 3.2.3-2 11:25:06 INFO - jsonschema == 2.5.1 11:25:06 INFO - manifestparser == 1.1 11:25:06 INFO - mozInstall == 1.13 11:25:06 INFO - mozcrash == 1.0 11:25:06 INFO - mozdebug == 0.1 11:25:06 INFO - mozdevice == 0.51 11:25:06 INFO - mozfile == 1.2 11:25:06 INFO - mozhttpd == 0.7 11:25:06 INFO - mozinfo == 0.10 11:25:06 INFO - mozleak == 0.1 11:25:06 INFO - mozlog == 3.5 11:25:06 INFO - moznetwork == 0.27 11:25:06 INFO - mozprocess == 0.25 11:25:06 INFO - mozprofile == 0.28 11:25:06 INFO - mozrunner == 6.13 11:25:06 INFO - mozscreenshot == 0.1 11:25:06 INFO - mozsystemmonitor == 0.3 11:25:06 INFO - moztest == 0.8 11:25:06 INFO - mozversion == 1.4 11:25:06 INFO - psutil == 3.1.1 11:25:06 INFO - requests == 1.2.3 11:25:06 INFO - wsgiref == 0.1.2 11:25:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:25: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')]} 11:25:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25: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')]} 11:25:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:06 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 0x1d001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x206ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2070090>, '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 0x2070d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x206af90>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1505753956.465478-1105325866', '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 11:25:06 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 11:25:06 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 11:25:06 INFO - Using env: {'DISPLAY': ':0', 11:25:06 INFO - 'HOME': '/home/cltbld', 11:25:06 INFO - 'LANG': 'en_US.UTF-8', 11:25:06 INFO - 'LANGUAGE': 'en_US:en', 11:25:06 INFO - 'LOGNAME': 'cltbld', 11:25:06 INFO - 'MAIL': '/var/mail/cltbld', 11:25:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:06 INFO - 'MOZ_NO_REMOTE': '1', 11:25:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:06 INFO - 'NO_EM_RESTART': '1', 11:25:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:06 INFO - 'PWD': '/builds/slave/test', 11:25:06 INFO - 'SHELL': '/bin/bash', 11:25:06 INFO - 'SHLVL': '1', 11:25:06 INFO - 'TERM': 'linux', 11:25:06 INFO - 'TMOUT': '86400', 11:25:06 INFO - 'USER': 'cltbld', 11:25:06 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1505753956.465478-1105325866', 11:25:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:06 INFO - '_': '/tools/buildbot/bin/python'} 11:25:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:06 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)) 11:25:06 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)) 11:25:06 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)) 11:25:06 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)) 11:25:06 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)) 11:25:06 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)) 11:25:06 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)) 11:25:06 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)) 11:25:06 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)) 11:25:06 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:25:06 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 11:25:06 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 11:25:06 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 11:25:06 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 11:25:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:25:08 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)) 11:25:08 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)) 11:25:08 INFO - Installing collected packages: simplejson 11:25:08 INFO - Running setup.py install for simplejson 11:25:08 INFO - building 'simplejson._speedups' extension 11:25:08 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 11:25:08 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 11:25:09 INFO - Successfully installed simplejson 11:25:09 INFO - Cleaning up... 11:25:09 INFO - Return code: 0 11:25:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:25: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')]} 11:25:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25: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')]} 11:25:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:09 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 0x1d001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x206ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2070090>, '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 0x2070d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x206af90>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1505753956.465478-1105325866', '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 11:25:09 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 11:25:09 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 11:25:09 INFO - Using env: {'DISPLAY': ':0', 11:25:09 INFO - 'HOME': '/home/cltbld', 11:25:09 INFO - 'LANG': 'en_US.UTF-8', 11:25:09 INFO - 'LANGUAGE': 'en_US:en', 11:25:09 INFO - 'LOGNAME': 'cltbld', 11:25:09 INFO - 'MAIL': '/var/mail/cltbld', 11:25:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:09 INFO - 'MOZ_NO_REMOTE': '1', 11:25:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:09 INFO - 'NO_EM_RESTART': '1', 11:25:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:09 INFO - 'PWD': '/builds/slave/test', 11:25:09 INFO - 'SHELL': '/bin/bash', 11:25:09 INFO - 'SHLVL': '1', 11:25:09 INFO - 'TERM': 'linux', 11:25:09 INFO - 'TMOUT': '86400', 11:25:09 INFO - 'USER': 'cltbld', 11:25:09 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1505753956.465478-1105325866', 11:25:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:09 INFO - '_': '/tools/buildbot/bin/python'} 11:25:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:25:09 INFO - Cleaning up... 11:25:09 INFO - Return code: 0 11:25:09 INFO - Running post-action listener: _resource_record_post_action 11:25:09 INFO - Running post-action listener: _start_resource_monitoring 11:25:09 INFO - Starting resource monitoring. 11:25:09 INFO - [mozharness: 2017-09-18 18:25:09.393458Z] Finished create-virtualenv step (success) 11:25:09 INFO - [mozharness: 2017-09-18 18:25:09.393977Z] Running install step. 11:25:09 INFO - Running pre-action listener: _resource_record_pre_action 11:25:09 INFO - Running main action method: install 11:25:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:25:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:25:09 INFO - Reading from file tmpfile_stdout 11:25:09 INFO - Detecting whether we're running mozinstall >=1.0... 11:25:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:25:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:25:09 INFO - Reading from file tmpfile_stdout 11:25:09 INFO - Output received: 11:25:09 INFO - Usage: mozinstall [options] installer 11:25:09 INFO - Options: 11:25:09 INFO - -h, --help show this help message and exit 11:25:09 INFO - -d DEST, --destination=DEST 11:25:09 INFO - Directory to install application into. [default: 11:25:09 INFO - "/builds/slave/test"] 11:25:09 INFO - --app=APP Application being installed. [default: firefox] 11:25:09 INFO - mkdir: /builds/slave/test/build/application 11:25:09 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'] 11:25:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:25:27 INFO - Reading from file tmpfile_stdout 11:25:27 INFO - Output received: 11:25:27 INFO - /builds/slave/test/build/application/firefox/firefox 11:25:27 INFO - Running post-action listener: _resource_record_post_action 11:25:27 INFO - [mozharness: 2017-09-18 18:25:27.489593Z] Finished install step (success) 11:25:27 INFO - [mozharness: 2017-09-18 18:25:27.489844Z] Running setup-mitmproxy step. 11:25:27 INFO - Running pre-action listener: _resource_record_pre_action 11:25:27 INFO - Running main action method: setup_mitmproxy 11:25:27 INFO - Skipping: mitmproxy is not required 11:25:27 INFO - Running post-action listener: _resource_record_post_action 11:25:27 INFO - [mozharness: 2017-09-18 18:25:27.490953Z] Finished setup-mitmproxy step (success) 11:25:27 INFO - [mozharness: 2017-09-18 18:25:27.491171Z] Running run-tests step. 11:25:27 INFO - Running pre-action listener: _resource_record_pre_action 11:25:27 INFO - Running pre-action listener: _set_gcov_prefix 11:25:27 INFO - Running main action method: run_tests 11:25:27 WARNING - Try message not found. 11:25:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:25:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:25:27 INFO - Python 2.7.3 11:25:27 INFO - Return code: 0 11:25:27 INFO - grabbing minidump binary from tooltool 11:25:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:27 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 0x2070090>, '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 0x2070d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x206af90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:25:27 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 11:25:27 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 11:25:27 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 11:25:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:25:27 INFO - Return code: 0 11:25:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:25:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:25:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:25:27 INFO - ENV: RUST_BACKTRACE is now full 11:25:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:25:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:25:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SnPiQaAJQmqSN7jo34Jbdw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-071', '--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 11:25:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SnPiQaAJQmqSN7jo34Jbdw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-071 --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 11:25:27 INFO - Using env: {'DISPLAY': ':0', 11:25:27 INFO - 'HOME': '/home/cltbld', 11:25:27 INFO - 'LANG': 'en_US.UTF-8', 11:25:27 INFO - 'LANGUAGE': 'en_US:en', 11:25:27 INFO - 'LOGNAME': 'cltbld', 11:25:27 INFO - 'MAIL': '/var/mail/cltbld', 11:25:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:25:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:25:27 INFO - 'MOZ_ACCELERATED': '1', 11:25:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:27 INFO - 'MOZ_NO_REMOTE': '1', 11:25:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:25:27 INFO - 'MOZ_WEBRENDER': '1', 11:25:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:27 INFO - 'NO_EM_RESTART': '1', 11:25:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:27 INFO - 'PWD': '/builds/slave/test', 11:25:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:25:27 INFO - 'RUST_BACKTRACE': 'full', 11:25:27 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:25:27 INFO - 'SHELL': '/bin/bash', 11:25:27 INFO - 'SHLVL': '1', 11:25:27 INFO - 'TERM': 'linux', 11:25:27 INFO - 'TMOUT': '86400', 11:25:27 INFO - 'USER': 'cltbld', 11:25:27 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1505753956.465478-1105325866', 11:25:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:27 INFO - '_': '/tools/buildbot/bin/python'} 11:25:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SnPiQaAJQmqSN7jo34Jbdw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-071', '--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 11:25:27 INFO - mozversion application_buildid: 20170918173522 11:25:27 INFO - mozversion application_changeset: 42151fcd6cfc216d147730d0f2c6a2acd52d22fd 11:25:27 INFO - mozversion application_display_name: Nightly 11:25:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:25:27 INFO - mozversion application_name: Firefox 11:25:27 INFO - mozversion application_remotingname: firefox 11:25:27 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:25:27 INFO - mozversion application_vendor: Mozilla 11:25:27 INFO - mozversion application_version: 57.0a1 11:25:27 INFO - mozversion platform_buildid: 20170918173522 11:25:27 INFO - mozversion platform_changeset: 42151fcd6cfc216d147730d0f2c6a2acd52d22fd 11:25:27 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:25:27 INFO - mozversion platform_version: 57.0a1 11:25:27 INFO - using testdate: 1505759127 11:25:27 INFO - actual date: 1505759127 11:25:27 INFO - starting webserver on 'localhost:39913' 11:25:27 INFO - SUITE-START | Running 2 tests 11:25:27 INFO - TEST-START | dromaeo_css 11:25:27 INFO - Initialising browser for dromaeo_css test... 11:25:27 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:39913/getInfo.html -profile /tmp/tmp0PuHJB/profile 11:25:27 INFO - TEST-INFO | started process 16744 (/builds/slave/test/build/application/firefox/firefox http://localhost:39913/getInfo.html) 11:25:34 INFO - TEST-INFO | 16744: exit 0 11:25:34 INFO - Browser initialized. 11:25:34 INFO - Running cycle 1/1 for dromaeo_css test... 11:25:34 INFO - Using env: {'DISPLAY': ':0', 11:25:34 INFO - 'HOME': '/home/cltbld', 11:25:34 INFO - 'JSGC_DISABLE_POISONING': '1', 11:25:34 INFO - 'LANG': 'en_US.UTF-8', 11:25:34 INFO - 'LANGUAGE': 'en_US:en', 11:25:34 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:25:34 INFO - 'LOGNAME': 'cltbld', 11:25:34 INFO - 'MAIL': '/var/mail/cltbld', 11:25:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:25:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:25:34 INFO - 'MOZ_ACCELERATED': '1', 11:25:34 INFO - 'MOZ_CRASHREPORTER': '1', 11:25:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:34 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:25:34 INFO - 'MOZ_NO_REMOTE': '1', 11:25:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:25:34 INFO - 'MOZ_WEBRENDER': '1', 11:25:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:34 INFO - 'NO_EM_RESTART': '1', 11:25:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:34 INFO - 'PWD': '/builds/slave/test', 11:25:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:25:34 INFO - 'RUST_BACKTRACE': 'full', 11:25:34 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:25:34 INFO - 'SHELL': '/bin/bash', 11:25:34 INFO - 'SHLVL': '1', 11:25:34 INFO - 'TERM': 'linux', 11:25:34 INFO - 'TMOUT': '86400', 11:25:34 INFO - 'USER': 'cltbld', 11:25:34 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1505753956.465478-1105325866', 11:25:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:34 INFO - '_': '/tools/buildbot/bin/python'} 11:25:34 INFO - TEST-INFO | started process 16988 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0PuHJB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:25:35 INFO - PID 16988 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 11:25:35 INFO - PID 16988 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 11:25:35 INFO - PID 16988 | 11:25:35 INFO - PID 16988 | (/builds/slave/test/build/application/firefox/firefox:17049): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:25:35 INFO - PID 16988 | 11:25:46 INFO - PID 16988 | RSS: Main: 200482816 11:25:46 INFO - PID 16988 | 11:28:44 INFO - PID 16988 | Cycle 1(1): loaded http://localhost:39913/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39913/tests/dromaeo/cssquery-ext.html) 11:28:45 INFO - PID 16988 | RSS: Main: 205287424 11:28:45 INFO - PID 16988 | 11:31:47 INFO - PID 16988 | Cycle 1(1): loaded http://localhost:39913/tests/dromaeo/cssquery-ext.html (next: http://localhost:39913/tests/dromaeo/cssquery-jquery.html) 11:31:48 INFO - PID 16988 | RSS: Main: 206548992 11:31:48 INFO - PID 16988 | 11:34:50 INFO - PID 16988 | Cycle 1(1): loaded http://localhost:39913/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39913/tests/dromaeo/cssquery-mootools.html) 11:34:50 INFO - PID 16988 | RSS: Main: 205451264 11:34:50 INFO - PID 16988 | 11:37:53 INFO - PID 16988 | Cycle 1(1): loaded http://localhost:39913/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39913/tests/dromaeo/cssquery-prototype.html) 11:37:53 INFO - PID 16988 | RSS: Main: 203665408 11:37:53 INFO - PID 16988 | 11:40:57 INFO - PID 16988 | Cycle 1(1): loaded http://localhost:39913/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39913/tests/dromaeo/cssquery-yui.html) 11:40:58 INFO - PID 16988 | RSS: Main: 207437824 11:40:58 INFO - PID 16988 | 11:44:00 INFO - PID 16988 | Cycle 1(1): loaded http://localhost:39913/tests/dromaeo/cssquery-yui.html (next: http://localhost:39913/tests/dromaeo/cssquery-dojo.html) 11:44:00 INFO - PID 16988 | RSS: Main: 207839232 11:44:00 INFO - PID 16988 | 11:44:00 INFO - PID 16988 | __start_tp_report 11:44:00 INFO - PID 16988 | _x_x_mozilla_page_load 11:44:00 INFO - PID 16988 | _x_x_mozilla_page_load_details 11:44:00 INFO - PID 16988 | |i|pagename|runs| 11:44:00 INFO - PID 16988 | |0;dojo.html;3100.984495077524;3110.5800716903213;3132.843357832109;3157.9210519737003;3158.952615710765;6183.969080154593;6240.219972503437;6301.338359472258;6344;6387.48900087993;6053.939460605393;6087.665178415185;6112.1137435072;6123.326434092246;6123.632582045069;5637.689927054011;5649.039663257236;5649.4633009864;5661.631993920402;5702.372738998728;5830.970845145768;5839.153322768196;5853.297604287492;5864.853378665546;5878;5740.483356497914;5871;5899.2920849497905;5904.143899134623;5929.466348028676;5588.105903055492;5642.153676948449;5696.2594862668;5774.076147816371;5853.560982926277;5665.830025099253;5757.712114394305;5769.480746732815;5777.768889244425;5800.796972105998;6176.907346389808;6188.195534580521;6189.288231853305;6281.403266689657;6384.3934826191435;6581.276059633485;6625.602463852184;6648.434883034948;6680.365365290289;6688.765893193715;6657.567258128206;6667.233268174125;6691.59850408977;6701.329867013308;6726.730930762764;6187.288461826903;6217.720202590849;6253.96873015632;6304.968475157595;6333.746650134035;6966.58200507961;6980.197277313073;7047.224805271416;7055.682494287769;7082.681279342339;6646.700898459581;6674.966625166843;6724.226713927863;6724.7646332378135;6748.156480439945;6606.372394622503;6683.933160668428;6714.563553369016;6716.093327400738;6739.460843132538;6673.265940746514;6702.530822842355;6706.329367063352;6709.563878347892;6791.219009813836;6724.125863637696;6759.729610815611;6780.355866192704;6788.151481064867;6816.284290149562;5267.920981185285;5295.887863548698;5335.893282134336;5338.706371149624;5345.278387417648;4545.5908968193025;4613.215753321943;4620.8151673933335;4635.026644404646;4637.327587499861;5693.60144789869;5697.515711164598;5713.685747283939;5718.428157184248;5730.77076916927;6661.833454163685;6676.732930682719;6727.091842601284;6755.459563234929;6807.761728339485;5756.827295181151;5763.7406316715005;5802.941970580325;5820.039693450533;5827.446392592697;5749.3963133871175;5771.769129234784;5820.185174075633;5849.181114643953;5866.970665146732;6452.4515416189215;6506.25178104524;6573.5398522103;6576.342365763386;6605.504587155887;6532.869342613026;6600.1089852869245;6726.697298621476;6809.93190068093;6815.420689241271;6407.391297826699;6510.5117116217425;6521.282658907611;6546;6575.835604109936;6654.13496245485;6733.595984240961;6761.290064543349;6774.593524388552;6778.3221677831825;6688.030235615905;6695.263521012782;6733.865322693617;6790.5925644461495;6841.726330946706;6365.204349456318;6463.095166676763;6492.707828147651;6539.149910511794;6596.076549283008;6498.837529061811;6499.805005849832;6581.572197807127;6582.670866456562;6613.537052406477;6454.967725161344;6466.935330646634;6502.577332473374;6521.804345869631;6535.934640653532;6509;6582.275949645631;6621;6659;6673.432758215606;6200.782972595937;6280.246370435394;6321.5574909757715;6400.359964003563;6413.4869210463985 11:44:00 INFO - PID 16988 | |1;ext.html;781.2382926646524;786.9213078692131;816.705985845096;821.6302663801291;829.7220431155566;39003.60996390035;39779.801100994526;39931.80034099833;40063.39904901425;40207;36054;36393.090172745695;36563.26873462529;36577.634223657755;36595.451068234;6805.591664500133;6897;6897.931020689804;6927.203371612279;6948.096747422828;6798;6896.586204827701;6902.6203558804245;6903.930960690379;6916.723331066752;6874.037634731141;6906.896396554056;7523.623818809065;7677.884831727529;7689;7551.848963020736;7565.432592555553;7604.885926711104;7659.195784442609;7681.193474685189;7381.261873812629;7579.696812127509;7586.355159811423;7591.848163036709;7604.201558836297;36936.261274774624;36993;37526.624733752586;37619.24761504755;37671;3354.8490317935753;3379.2396710739886;3380.8985730428126;3416.974907527732;3419.2135808763874;29126.41747165045;29205.41589168205;29269;29442.263943401587;29498;5073.365829271341;5076.847694569169;5109.080365534202;5143.614228932807;5216.660917040418;173857.1307143469;185088;190359;191356;193938.9999999986;46951.765241173576;46969;47148.764256178496;47232.7638361806;47395.28907066397;48528;48946.51053489491;49026.26460603094;49184.50815491871;49190.262146067835;15388.230588470531;15492.5352239433;15502.689946201013;15565.143917084442;15656.608584785243;12739.61781146567;12766.872331276754;12782.360881955865;12814.615561533168;12859.035572331926;13452.260125692985;13661.931690341484;13777;13813.51652692151;13942.790858137136;5594.517452874991;5645.943540564624;5681.602287839812;5739.65562066269;5801.767929282782;995.6913356859396;1004.1013293102632;1009.0817356205818;1016.7102375823002;1018.8420794776821;21804;21876.343709688736;22504.662430063563;22563.77436225617;22686.773132268798;1074.414444127952;1088.8638920134983;1090.5038207615517;1108.3516143056402;1117.9664610061711;11761.235519691192;11783.351915644722;11824.23142495735;11868.525258989717;11947.402629868646;213485;213685;213945;215535;215734;50626.49373506291;51070.23394649083;51406.74296628493;51427.48572514227;51459;1359.3746876436753;1422.679897023182;1429.5711286614182;1440.8703216710337;1450.470578238935;21751.564968700222;21865.739144340358;21871;21880.12479500802;22056.228032018804;35269.64730352664;35521.82239088891;35583.82208088943;35596.644033559336;35620.82189589035;138191.30904345415;138485.3075734615;138883;138886;139118;29826.403471930007;30122.849385752932;32141.196470088435;32351.352972939938;32743.836280818443;40767.18465630611;40999.59000409958;41007.79496102501;41492.79253603713;41753.58246417497;30164.5475317866;30654.693453065185;30724.539131913487;30848.074557763302;31106.377872442878;30008.849955750953;30269;30290.24274393158;31269.218269543442;31592;33766.98699039033;34038;34116;34348;34400.82799585986;29518.262043449085;29741.553876691432;29773.404531909673;30186.396272073995;30760.692393075784;21822.236221732164;22583.548329032998;22869.656955145354;22876.08495660155;23163.76836231616 11:44:00 INFO - PID 16988 | |2;jquery.html;546.9617126801126;554.6644280210472;556.73276827123;571.9513841323487;597.1669521018179;21405.250816221436;22151.446213844643;22322.77677223227;22345.44136396591;22419.55160896781;23849.880750596265;24055.63916541249;24350;24881.502369952592;25211;6439.742410303594;6523.9673801630925;6558.2130144382745;6617.536772425932;6623.801285961429;6403.455706264973;6422.293547709748;6492.766374388874;6506.512011599125;6507.51193660475;6114.2968558615885;6329.556931014831;6347.270063942637;6363.490920726331;6408.807735767911;6310.085037669535;6357.2371315442215;6375.968120159369;6376.36236376361;6384.93615063848;5903.763849446017;5916.763329466816;5930.318013428468;5949.732262048218;6110.08348747687;28451.85774071137;28954.855225723946;28984.27539311513;29073.709262907312;29073.709262907523;2060.958780824375;2088.976401563238;2089.3209706845337;2089.6447603907222;2095.245711543843;18801;19144.23423063076;19263.651544391898;19324.1304141314;19439.708404373945;2416.4683769570665;2429.4248097017044;2448.951020979588;2469.9135530256535;2475.5048990201853;114301;117795.05512362174;117942;132391;136184;19931.800681993285;20727.27454539084;20764.792352076587;22008.669869951962;22257.554848903255;41713.58286417097;41733.79133104376;41786.373204401956;41799.164016720104;42154;10167.796644067077;10183.949080254552;10212.08091271789;10236.181105511541;10316.123129534073;8333.416650836321;8388.580570971428;8408.117147699526;8475.915240847637;8545.957270213608;10752.892471075345;11090.168237382228;11140.610078647209;11275.718107047389;11306.208565400508;3966.167104907944;4260.25445547028;4267.679924005712;4360.171567402183;4468.352088947149;930.7161315798611;942.6936245720168;961.3462845265148;965.5510187762724;969.1229437359201;18805.341813036477;18847.340343087926;19367.51581210481;19434.70847937282;19565.608687826447;1009.9444530550891;1014.1886490807325;1021.8927012663712;1029.9691009269734;1032.390889375272;10491.68524944253;10542.367457952547;10630.362178269328;10710.678679639623;10819.13446924244;443210.70431978937;455876;459015;460237;465516;111577.44211278892;113346.43326783313;113545;114055.42972285085;114656.42671786588;1023.518946095334;1066.722652110457;1133.1897693149274;1164.6447833410891;1185.3954483213622;20525.794742052985;20608.793912061286;20622.896885515478;20745.792542074385;20771.376858694264;57972.13041804461;59277.407225927185;59463.70268148631;59824;60032.699836500535;73043.63478182575;73464.26535734574;73711.26288737259;73871;74577.25422745703;19819.207231711145;20407.4898127548;20454;20554.075066622336;20836.166553337698;22276.554468910206;22341.441463963532;22350.105995759986;22530.66204006974;22635.886820565793;17530;18134.54663633367;18188.36340728068;18364.989925554222;18437.354692585694;16491.91754041222;16917.238724257193;16942.745858811882;16949.74575381395;16976.74534881953;18190.181441834884;18401.3559525416;18791.34230301933;18803.71794423112;18881.150348234638;19775.802241977395;19833.30583429573;20115.497112572302;20181.39455816328;20278.79721202769;18087.728684069487;18280.268789248814;18317.08414579239;18339.816601833812;18385.080745962914 11:44:00 INFO - PID 16988 | |3;mootools.html;1316.9473221071157;1406.3952500424816;1409.4362255097965;1410.7954346619747;1415.9150450972936;14647.926760366197;15402.075875447466;15437.536873893772;15464.458743943964;15481.225938703075;14932.925335373335;15045.92477037616;15099.169545674984;15145.167015814126;15197.316120774563;2635.3279913622;2702.6216329713807;2715;2717.91846244613;2738.411241583059;2692.892284308635;2760.627315312427;2780.88876444942;2789.0377819652185;2794.119852246546;2703.999520177537;2706.066407089551;2741.0954385052983;2820.125761014082;2822.717728227171;2746.368335282896;2749.285185851673;2774.3202915285683;2775.597538356947;2783.498970185366;2590.961135582968;2668.7064422913463;2678.08944958715;2679.5712685970348;2680.437108207279;14808.481703140445;15232.162231077285;15246.542603721795;15291.617709557238;15322.540323790192;7829.3736501079775;8136.674533018672;8141.43009989301;8145.266925976691;8149.755507334789;5345.786168553253;5556.749946252428;5687.772489100431;5688.97155514224;5732.570057245724;1691.205133587212;1746.9475915722549;1747.3971479839563;1777.742227377036;1788.9642207155784;25671.48657026849;26068.34829129268;26080.34799130018;26136.085237016803;26219;6839.692213850389;6878.38094571491;6879.105716256855;6979.616121113286;7088.716451341992;16966.15169241533;17008.744868826976;17020.404285849934;17044.829551704574;17078.829211707725;7653.311201991847;7911.604419778988;7914.683412663429;7926.801829954182;7938.801529961797;7155.7495487658725;7174.641267936687;7311.780646580611;7366.116066072105;7427.294407031323;4894.094592500328;5031.7987280509105;5035.295058691786;5053.722045287471;5064.46823083571;1421.644588852787;1442.228407801821;1458.4457905995653;1461.2474575593578;1472.7717203833422;880.4365206267994;896.9819255145457;909.3361845852432;915.0483497162876;932.4032619123766;8072.192780721881;8137.349012079019;8152.38857085721;8165.428420010542;8187.140350263256;974.7855471796194;997.581015973293;1006.808706345792;1006.9748256293651;1009.4246279620546;5190.844274671766;5274.868128296824;5315.521603055666;5344.5724342052545;5368.114261146945;21268.468288292916;21273.255436059662;21403.67894481584;21901.123955041938;22102.77897221007;20324.390268291976;20744.377668669964;21427.357179284645;21453.356399307733;21700.240491582717;10849.945750271356;11145.164112691418;11170.106391488662;11171.44142792857;11176.217664763552;7907.327877130509;8266.875996859932;8387.622556985072;8394.412391132806;8462.407631465738;17394;17657.646847063243;18658.44024679262;19016;19202.13590388408;18612.25550978;19111.331103411314;19437.31969381065;19472.61054778925;19508;11099.389533575732;11281.887181128084;11316.094712423152;11328.433578321215;11349.48927298257;13639.79540306916;13644.590662280147;13812.516561920285;13947.093438926437;13955.58133256004;11242;11578.478968446272;11612.94193529027;11627.186096973131;11786.882131178578;11336.886631133913;11365.772684546428;11400.828987565028;11491.482883270106;11504.53981840717;9618.326717129734;9744.658936937172;9751.707448776548;9828.606855725691;9852.014798520091;7097.503174777716;7118.822029449098;7135.215126335995;7168.426525877813;7221.602811845399;6950.374466298057;7271.291246556949;7327.560346379234;7357.117145942521;7385.778426647209 11:44:00 INFO - PID 16988 | |4;prototype.html;487.0939285851263;494.7655938645178;512.2725729464161;521.2051621277551;523.4765234765234;6278.2779980302275;6341.873162536758;6368.904466433001;6388.520860935437;6388.64862432566;6213.130161777343;6293.27627322858;6317.557770956023;6336.841578960528;6352.428281454668;5203.4536373680785;5225.973870130644;5232.189010703347;5234.607404444682;5245.816396426126;5151.716655583941;5161.535461808437;5236.345456817898;5271.789128434858;5318.46815318467;4862.44081930579;4965.808206030562;4966.108383242503;4988.678000329915;5021.899562008758;4869.82955596556;4931.901361972777;4956.157453232941;4999.525045120708;5025.673331233476;4431.423914891044;4467.3299005149165;4470.575295346936;4477.820887164509;4485.170243504962;6110.297315808694;6111.816645500642;6172.321044685081;6201.503879689614;6210.130581718563;5705.714714264312;5729.742161602696;5748.137779333092;5749.170696614864;5766.538676905838;6558.93441065588;6589.439897608709;6643.501737369668;6659.733610655568;6713.328667133248;4633.582977532004;4772.665913386064;4840.128776820171;4842.854714358575;4877;6690.966545167243;6825.658717064177;6845.212800527953;6889.414399775975;6918.06606108179;4968.739223653229;4999.400071991385;5003.2995380646735;5031.823886163967;5045.789010637421;5074.644774865724;5089.9745501272255;5112.284280200774;5121.231815227671;5124.5131712487255;5669.546436285087;5672.376038635747;5690.95125754728;5721.8569535761935;5737.221461346912;6606.669666516655;6637.601743895381;6671.43292820106;6726.6636668167375;6726.932730672631;1751.6234009687978;1753.7460715588415;1773.3349993752342;1776.1829558403278;1783.839454449106;1141.8743938166795;1212.7635111153418;1213.1811027556364;1225.8590262119792;1227.245244174826;5588.608797384144;5647.29408823897;5692.743826527816;5696.430356964353;5733.541316694655;6673.766418175341;6697.7655782047395;6731.259561448237;6769.661516924134;6779.15260592426;5577.075908811454;5647.858803529863;5653.971730141323;5660;5679.6876171810945;3546.6453354664845;3574.303010912899;3581.5344005279667;3587.1390866191928;3621.8189090545366;6363.09107267827;6401.583897046677;6456.870862582722;6484.935150648527;6552.475801935833;6753.602471122779;6834.1457317835275;6846.486513511507;6866.759663411756;6940.861182776417;5887.470127688529;6390.297067322591;6463.030545418131;6489.7404103835315;6507.511936604868;6534.934650653433;6536.182977127859;6558.967205163944;6635.502337324817;6664.500162487736;6577.375149360803;6608.8347791305605;6629.138212032405;6677;6683.43190828785;6342.23893132827;6366.2360516736435;6446.8388290293115;6461.19235095613;6564.901526477011;4984.975075124601;5000.67495612784;5008.398992120969;5009.649324547247;5018.498150185098;6500.3174666659315;6617.437517810848;6635.469162467088;6795.490338224752;6814.216365117876;6475.514336424882;6528.89008868503;6569.211694596679;6607.372299631527;6614.66926653675;6488.935110648833;6497.220333559814;6542.149520562297;6555.4427873631275;6574.342565743387;6425.678716064084;6461.741530338733;6475.708593113415;6509.4792416605615;6532.444742196966;6584;6589.505787066085;6636.668166591555;6668;6695.933040669531;6277.937220627918;6333.1766870306565;6418.614883107029;6434.64609446485;6488.740450381932 11:44:00 INFO - PID 16988 | |5;yui.html;926.1849572376312;928.3130483442254;937.3860121620341;943.5140902435243;953.6280850468316;18159.636807263847;18607.62784744306;18643.627127457443;18648.06759662015;18707.532311692197;17888.28446862124;17957.461276161703;18049;18169.454916352497;18213.544661383472;970.0784254957783;987.146118607403;989.9950500247488;993.3692105513015;994.0854413939194;986.0927946289395;986.6941248213041;988.9258305627106;991.4051569058579;994.1500017485055;984.4339504784741;1031.046282188976;1046.785408991155;1047.842823576462;1048.6120135549857;1030.644427672452;1031.020530496028;1038.7247379444452;1041.3751748950683;1042.067349722002;754.9433792465533;757.307064036406;757.5530437042172;757.7158565537924;757.9696812127509;19285.132169052427;19422.611547769106;19503.90248048765;19533.609327813505;19562.217511299532;21300.36098917035;21409.357719268446;21423.67864482034;21533.138674453003;21537.56924861494;16363.59091022722;16654.58363540909;16680.83319166817;16718;16874.83125168745;3726.5528136623507;3748.137928276484;3759.3233218020746;3760.9623903760885;3761.680257178143;123919;133083.33458332648;137452.999999999;137834;139216;17028.233729482203;17884;17939;17969.550761231072;17975.910120449313;31134.844325778227;31426.685733142833;31737.206569835478;31889.043328700176;31906;8570.142985701379;8826.602802873886;8957.552122393985;8971.551422428853;9019.594118264693;3642.61752515982;3746.7939263340777;3768.9434658480145;3778.8299526521373;3789.6778773804535;5384.5692344612335;5386.461353864583;5386.461353864661;5396.379416367089;5399.379071406838;1088.080571916729;1129.5707631100129;1132.28665940457;1134.3647557367901;1142.114860982745;616.5961295351552;653.8953767397194;654.9115869357671;662.9933700662932;667.219353356574;11764.35296058725;11834.822477662841;12207.694807629703;12225.449854756558;12587.559435419716;654.6006935769177;663.2041550139852;665.7303791964263;666.7899611622323;671.7145213284334;5407.215953686772;5483.8080667177255;5492.47821456961;5589.74846131925;5609.326880774333;121631;122289.38855305666;122650;126648;126994;107890;109239;109675;110325.44837275923;111053;92523;93474.53262733643;95413.52293238629;99245;99847;9943.353682010646;10023.849642255225;10026.298159128792;10194.235432342752;10202.795944081225;43443.56556434395;43686;44008.33987490126;45635.77182114068;45831;55666.16500752573;56041;56280;57238;57717.483635637174;15233.086014839146;15297.77053344223;15345.769813452584;15365.308561115;15491.147986860831;16853.325866965184;17271.222794974507;17274.136293185038;17372.218250179027;17546.21042053085;13579.456821727415;13818.96357773191;13832.446702131801;14124.576262712135;14167.079139856289;15098.169600671628;15485.070895746292;15488.5353439397;15575.688486230438;15652.452164174654;15045.473408430653;15130.394784208509;15166.317515711598;15196.848031519985;15516.069035857885;11566.65300041;11659.825102623297;11746.412679365827;11922.105842061706;12046.638600841989;11240.15698822608;11240.437978101227;11413.144014198802;11438.313701177956;11461.885381146081 11:44:00 INFO - PID 16988 | __end_tp_report 11:44:00 INFO - PID 16988 | __start_cc_report 11:44:00 INFO - PID 16988 | _x_x_mozilla_cycle_collect,269 11:44:00 INFO - PID 16988 | __end_cc_report 11:44:00 INFO - PID 16988 | __startTimestamp1505760240357__endTimestamp 11:44:00 INFO - PID 16988 | 11:44:00 INFO - PID 16988 | ------- Summary: start ------- 11:44:00 INFO - PID 16988 | Number of tests: 6 11:44:00 INFO - PID 16988 | 11:44:00 INFO - PID 16988 | [#0] dojo.html Cycles:165 Average:6176.00 Median:6452.45 stddev:748.11 (11.6%) stddev-sans-first:710.45 11:44:00 INFO - PID 16988 | Values: 3101.0 3110.6 3132.8 3157.9 3159.0 6184.0 6240.2 6301.3 6344.0 6387.5 6053.9 6087.7 6112.1 6123.3 6123.6 5637.7 5649.0 5649.5 5661.6 5702.4 5831.0 5839.2 5853.3 5864.9 5878.0 5740.5 5871.0 5899.3 5904.1 5929.5 5588.1 5642.2 5696.3 5774.1 5853.6 5665.8 5757.7 5769.5 5777.8 5800.8 6176.9 6188.2 6189.3 6281.4 6384.4 6581.3 6625.6 6648.4 6680.4 6688.8 6657.6 6667.2 6691.6 6701.3 6726.7 6187.3 6217.7 6254.0 6305.0 6333.7 6966.6 6980.2 7047.2 7055.7 7082.7 6646.7 6675.0 6724.2 6724.8 6748.2 6606.4 6683.9 6714.6 6716.1 6739.5 6673.3 6702.5 6706.3 6709.6 6791.2 6724.1 6759.7 6780.4 6788.2 6816.3 5267.9 5295.9 5335.9 5338.7 5345.3 4545.6 4613.2 4620.8 4635.0 4637.3 5693.6 5697.5 5713.7 5718.4 5730.8 6661.8 6676.7 6727.1 6755.5 6807.8 5756.8 5763.7 5802.9 5820.0 5827.4 5749.4 5771.8 5820.2 5849.2 5867.0 6452.5 6506.3 6573.5 6576.3 6605.5 6532.9 6600.1 6726.7 6809.9 6815.4 6407.4 6510.5 6521.3 6546.0 6575.8 6654.1 6733.6 6761.3 6774.6 6778.3 6688.0 6695.3 6733.9 6790.6 6841.7 6365.2 6463.1 6492.7 6539.1 6596.1 6498.8 6499.8 6581.6 6582.7 6613.5 6455.0 6466.9 6502.6 6521.8 6535.9 6509.0 6582.3 6621.0 6659.0 6673.4 6200.8 6280.2 6321.6 6400.4 6413.5 11:44:00 INFO - PID 16988 | 11:44:00 INFO - PID 16988 | [#1] ext.html Cycles:180 Average:34431.04 Median:18573.11 stddev:47396.80 (255.2%) stddev-sans-first:47462.41 11:44:00 INFO - PID 16988 | Values: 781.2 786.9 816.7 821.6 829.7 39003.6 39779.8 39931.8 40063.4 40207.0 36054.0 36393.1 36563.3 36577.6 36595.5 6805.6 6897.0 6897.9 6927.2 6948.1 6798.0 6896.6 6902.6 6903.9 6916.7 6874.0 6906.9 7523.6 7677.9 7689.0 7551.8 7565.4 7604.9 7659.2 7681.2 7381.3 7579.7 7586.4 7591.8 7604.2 36936.3 36993.0 37526.6 37619.2 37671.0 3354.8 3379.2 3380.9 3417.0 3419.2 29126.4 29205.4 29269.0 29442.3 29498.0 5073.4 5076.8 5109.1 5143.6 5216.7 173857.1 185088.0 190359.0 191356.0 193939.0 46951.8 46969.0 47148.8 47232.8 47395.3 48528.0 48946.5 49026.3 49184.5 49190.3 15388.2 15492.5 15502.7 15565.1 15656.6 12739.6 12766.9 12782.4 12814.6 12859.0 13452.3 13661.9 13777.0 13813.5 13942.8 5594.5 5645.9 5681.6 5739.7 5801.8 995.7 1004.1 1009.1 1016.7 1018.8 21804.0 21876.3 22504.7 22563.8 22686.8 1074.4 1088.9 1090.5 1108.4 1118.0 11761.2 11783.4 11824.2 11868.5 11947.4 213485.0 213685.0 213945.0 215535.0 215734.0 50626.5 51070.2 51406.7 51427.5 51459.0 1359.4 1422.7 1429.6 1440.9 1450.5 21751.6 21865.7 21871.0 21880.1 22056.2 35269.6 35521.8 35583.8 35596.6 35620.8 138191.3 138485.3 138883.0 138886.0 139118.0 29826.4 30122.8 32141.2 32351.4 32743.8 40767.2 40999.6 41007.8 41492.8 41753.6 30164.5 30654.7 30724.5 30848.1 31106.4 30008.8 30269.0 30290.2 31269.2 31592.0 33767.0 34038.0 34116.0 34348.0 34400.8 29518.3 29741.6 29773.4 30186.4 30760.7 21822.2 22583.5 22869.7 22876.1 23163.8 11:44:00 INFO - PID 16988 | 11:44:00 INFO - PID 16988 | [#2] jquery.html Cycles:180 Average:34549.62 Median:22204.50 stddev:76858.52 (346.1%) stddev-sans-first:77031.72 11:44:00 INFO - PID 16988 | Values: 547.0 554.7 556.7 572.0 597.2 21405.3 22151.4 22322.8 22345.4 22419.6 23849.9 24055.6 24350.0 24881.5 25211.0 6439.7 6524.0 6558.2 6617.5 6623.8 6403.5 6422.3 6492.8 6506.5 6507.5 6114.3 6329.6 6347.3 6363.5 6408.8 6310.1 6357.2 6376.0 6376.4 6384.9 5903.8 5916.8 5930.3 5949.7 6110.1 28451.9 28954.9 28984.3 29073.7 29073.7 2061.0 2089.0 2089.3 2089.6 2095.2 18801.0 19144.2 19263.7 19324.1 19439.7 2416.5 2429.4 2449.0 2469.9 2475.5 114301.0 117795.1 117942.0 132391.0 136184.0 19931.8 20727.3 20764.8 22008.7 22257.6 41713.6 41733.8 41786.4 41799.2 42154.0 10167.8 10183.9 10212.1 10236.2 10316.1 8333.4 8388.6 8408.1 8475.9 8546.0 10752.9 11090.2 11140.6 11275.7 11306.2 3966.2 4260.3 4267.7 4360.2 4468.4 930.7 942.7 961.3 965.6 969.1 18805.3 18847.3 19367.5 19434.7 19565.6 1009.9 1014.2 1021.9 1030.0 1032.4 10491.7 10542.4 10630.4 10710.7 10819.1 443210.7 455876.0 459015.0 460237.0 465516.0 111577.4 113346.4 113545.0 114055.4 114656.4 1023.5 1066.7 1133.2 1164.6 1185.4 20525.8 20608.8 20622.9 20745.8 20771.4 57972.1 59277.4 59463.7 59824.0 60032.7 73043.6 73464.3 73711.3 73871.0 74577.3 19819.2 20407.5 20454.0 20554.1 20836.2 22276.6 22341.4 22350.1 22530.7 22635.9 17530.0 18134.5 18188.4 18365.0 18437.4 16491.9 16917.2 16942.7 16949.7 16976.7 18190.2 18401.4 18791.3 18803.7 18881.2 19775.8 19833.3 20115.5 20181.4 20278.8 18087.7 18280.3 18317.1 18339.8 18385.1 11:44:00 INFO - PID 16988 | 11:44:00 INFO - PID 16988 | [#3] mootools.html Cycles:180 Average:9303.86 Median:2673.40 stddev:6607.78 (247.2%) stddev-sans-first:6599.06 11:44:00 INFO - PID 16988 | Values: 1316.9 1406.4 1409.4 1410.8 1415.9 14647.9 15402.1 15437.5 15464.5 15481.2 14932.9 15045.9 15099.2 15145.2 15197.3 2635.3 2702.6 2715.0 2717.9 2738.4 2692.9 2760.6 2780.9 2789.0 2794.1 2704.0 2706.1 2741.1 2820.1 2822.7 2746.4 2749.3 2774.3 2775.6 2783.5 2591.0 2668.7 2678.1 2679.6 2680.4 14808.5 15232.2 15246.5 15291.6 15322.5 7829.4 8136.7 8141.4 8145.3 8149.8 5345.8 5556.7 5687.8 5689.0 5732.6 1691.2 1746.9 1747.4 1777.7 1789.0 25671.5 26068.3 26080.3 26136.1 26219.0 6839.7 6878.4 6879.1 6979.6 7088.7 16966.2 17008.7 17020.4 17044.8 17078.8 7653.3 7911.6 7914.7 7926.8 7938.8 7155.7 7174.6 7311.8 7366.1 7427.3 4894.1 5031.8 5035.3 5053.7 5064.5 1421.6 1442.2 1458.4 1461.2 1472.8 880.4 897.0 909.3 915.0 932.4 8072.2 8137.3 8152.4 8165.4 8187.1 974.8 997.6 1006.8 1007.0 1009.4 5190.8 5274.9 5315.5 5344.6 5368.1 21268.5 21273.3 21403.7 21901.1 22102.8 20324.4 20744.4 21427.4 21453.4 21700.2 10849.9 11145.2 11170.1 11171.4 11176.2 7907.3 8266.9 8387.6 8394.4 8462.4 17394.0 17657.6 18658.4 19016.0 19202.1 18612.3 19111.3 19437.3 19472.6 19508.0 11099.4 11281.9 11316.1 11328.4 11349.5 13639.8 13644.6 13812.5 13947.1 13955.6 11242.0 11578.5 11612.9 11627.2 11786.9 11336.9 11365.8 11400.8 11491.5 11504.5 9618.3 9744.7 9751.7 9828.6 9852.0 7097.5 7118.8 7135.2 7168.4 7221.6 6950.4 7271.3 7327.6 7357.1 7385.8 11:44:00 INFO - PID 16988 | 11:44:00 INFO - PID 16988 | [#4] prototype.html Cycles:180 Average:5523.09 Median:6211.63 stddev:1544.09 (24.9%) stddev-sans-first:1501.45 11:44:00 INFO - PID 16988 | Values: 487.1 494.8 512.3 521.2 523.5 6278.3 6341.9 6368.9 6388.5 6388.6 6213.1 6293.3 6317.6 6336.8 6352.4 5203.5 5226.0 5232.2 5234.6 5245.8 5151.7 5161.5 5236.3 5271.8 5318.5 4862.4 4965.8 4966.1 4988.7 5021.9 4869.8 4931.9 4956.2 4999.5 5025.7 4431.4 4467.3 4470.6 4477.8 4485.2 6110.3 6111.8 6172.3 6201.5 6210.1 5705.7 5729.7 5748.1 5749.2 5766.5 6558.9 6589.4 6643.5 6659.7 6713.3 4633.6 4772.7 4840.1 4842.9 4877.0 6691.0 6825.7 6845.2 6889.4 6918.1 4968.7 4999.4 5003.3 5031.8 5045.8 5074.6 5090.0 5112.3 5121.2 5124.5 5669.5 5672.4 5691.0 5721.9 5737.2 6606.7 6637.6 6671.4 6726.7 6726.9 1751.6 1753.7 1773.3 1776.2 1783.8 1141.9 1212.8 1213.2 1225.9 1227.2 5588.6 5647.3 5692.7 5696.4 5733.5 6673.8 6697.8 6731.3 6769.7 6779.2 5577.1 5647.9 5654.0 5660.0 5679.7 3546.6 3574.3 3581.5 3587.1 3621.8 6363.1 6401.6 6456.9 6484.9 6552.5 6753.6 6834.1 6846.5 6866.8 6940.9 5887.5 6390.3 6463.0 6489.7 6507.5 6534.9 6536.2 6559.0 6635.5 6664.5 6577.4 6608.8 6629.1 6677.0 6683.4 6342.2 6366.2 6446.8 6461.2 6564.9 4985.0 5000.7 5008.4 5009.6 5018.5 6500.3 6617.4 6635.5 6795.5 6814.2 6475.5 6528.9 6569.2 6607.4 6614.7 6488.9 6497.2 6542.1 6555.4 6574.3 6425.7 6461.7 6475.7 6509.5 6532.4 6584.0 6589.5 6636.7 6668.0 6695.9 6277.9 6333.2 6418.6 6434.6 6488.7 11:44:00 INFO - PID 16988 | 11:44:00 INFO - PID 16988 | [#5] yui.html Cycles:180 Average:24075.72 Median:18645.85 stddev:35071.30 (188.1%) stddev-sans-first:35126.60 11:44:00 INFO - PID 16988 | Values: 926.2 928.3 937.4 943.5 953.6 18159.6 18607.6 18643.6 18648.1 18707.5 17888.3 17957.5 18049.0 18169.5 18213.5 970.1 987.1 990.0 993.4 994.1 986.1 986.7 988.9 991.4 994.2 984.4 1031.0 1046.8 1047.8 1048.6 1030.6 1031.0 1038.7 1041.4 1042.1 754.9 757.3 757.6 757.7 758.0 19285.1 19422.6 19503.9 19533.6 19562.2 21300.4 21409.4 21423.7 21533.1 21537.6 16363.6 16654.6 16680.8 16718.0 16874.8 3726.6 3748.1 3759.3 3761.0 3761.7 123919.0 133083.3 137453.0 137834.0 139216.0 17028.2 17884.0 17939.0 17969.6 17975.9 31134.8 31426.7 31737.2 31889.0 31906.0 8570.1 8826.6 8957.6 8971.6 9019.6 3642.6 3746.8 3768.9 3778.8 3789.7 5384.6 5386.5 5386.5 5396.4 5399.4 1088.1 1129.6 1132.3 1134.4 1142.1 616.6 653.9 654.9 663.0 667.2 11764.4 11834.8 12207.7 12225.4 12587.6 654.6 663.2 665.7 666.8 671.7 5407.2 5483.8 5492.5 5589.7 5609.3 121631.0 122289.4 122650.0 126648.0 126994.0 107890.0 109239.0 109675.0 110325.4 111053.0 92523.0 93474.5 95413.5 99245.0 99847.0 9943.4 10023.8 10026.3 10194.2 10202.8 43443.6 43686.0 44008.3 45635.8 45831.0 55666.2 56041.0 56280.0 57238.0 57717.5 15233.1 15297.8 15345.8 15365.3 15491.1 16853.3 17271.2 17274.1 17372.2 17546.2 13579.5 13819.0 13832.4 14124.6 14167.1 15098.2 15485.1 15488.5 15575.7 15652.5 15045.5 15130.4 15166.3 15196.8 15516.1 11566.7 11659.8 11746.4 11922.1 12046.6 11240.2 11240.4 11413.1 11438.3 11461.9 11:44:00 INFO - PID 16988 | -------- Summary: end -------- 11:44:00 INFO - PID 16988 | 11:44:01 INFO - TEST-INFO | 16988: exit 0 11:44:01 INFO - TEST-OK | dromaeo_css | took 1113440ms 11:44:01 INFO - TEST-START | kraken 11:44:01 INFO - Initialising browser for kraken test... 11:44:01 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:39913/getInfo.html -profile /tmp/tmpoVog1K/profile 11:44:01 INFO - TEST-INFO | started process 17372 (/builds/slave/test/build/application/firefox/firefox http://localhost:39913/getInfo.html) 11:44:07 INFO - TEST-INFO | 17372: exit 0 11:44:07 INFO - Browser initialized. 11:44:07 INFO - Running cycle 1/1 for kraken test... 11:44:07 INFO - Using env: {'DISPLAY': ':0', 11:44:07 INFO - 'HOME': '/home/cltbld', 11:44:07 INFO - 'JSGC_DISABLE_POISONING': '1', 11:44:07 INFO - 'LANG': 'en_US.UTF-8', 11:44:07 INFO - 'LANGUAGE': 'en_US:en', 11:44:07 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:44:07 INFO - 'LOGNAME': 'cltbld', 11:44:07 INFO - 'MAIL': '/var/mail/cltbld', 11:44:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:44:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:44:07 INFO - 'MOZ_ACCELERATED': '1', 11:44:07 INFO - 'MOZ_CRASHREPORTER': '1', 11:44:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:07 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:44:07 INFO - 'MOZ_NO_REMOTE': '1', 11:44:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:44:07 INFO - 'MOZ_WEBRENDER': '1', 11:44:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:44:07 INFO - 'NO_EM_RESTART': '1', 11:44:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:44:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:07 INFO - 'PWD': '/builds/slave/test', 11:44:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:44:07 INFO - 'RUST_BACKTRACE': 'full', 11:44:07 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:44:07 INFO - 'SHELL': '/bin/bash', 11:44:07 INFO - 'SHLVL': '1', 11:44:07 INFO - 'TERM': 'linux', 11:44:07 INFO - 'TMOUT': '86400', 11:44:07 INFO - 'USER': 'cltbld', 11:44:07 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1505753956.465478-1105325866', 11:44:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:07 INFO - '_': '/tools/buildbot/bin/python'} 11:44:07 INFO - TEST-INFO | started process 17618 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoVog1K/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:44:08 INFO - PID 17618 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 11:44:08 INFO - PID 17618 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 11:44:08 INFO - PID 17618 | 11:44:08 INFO - PID 17618 | (/builds/slave/test/build/application/firefox/firefox:17677): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:44:08 INFO - PID 17618 | 11:44:18 INFO - PID 17618 | RSS: Main: 204148736 11:44:18 INFO - PID 17618 | 11:44:21 INFO - PID 17618 | Cycle 1(1): loaded http://localhost:39913/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39913/tests/kraken/driver.html?testName=audio-beat-detection) 11:44:22 INFO - PID 17618 | RSS: Main: 206794752 11:44:22 INFO - PID 17618 | 11:44:25 INFO - PID 17618 | Cycle 1(1): loaded http://localhost:39913/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39913/tests/kraken/driver.html?testName=audio-dft) 11:44:25 INFO - PID 17618 | RSS: Main: 206454784 11:44:25 INFO - PID 17618 | 11:44:28 INFO - PID 17618 | Cycle 1(1): loaded http://localhost:39913/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39913/tests/kraken/driver.html?testName=audio-fft) 11:44:29 INFO - PID 17618 | RSS: Main: 202711040 11:44:29 INFO - PID 17618 | 11:44:31 INFO - PID 17618 | Cycle 1(1): loaded http://localhost:39913/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39913/tests/kraken/driver.html?testName=audio-oscillator) 11:44:32 INFO - PID 17618 | RSS: Main: 202457088 11:44:32 INFO - PID 17618 | 11:44:34 INFO - PID 17618 | Cycle 1(1): loaded http://localhost:39913/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39913/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:44:35 INFO - PID 17618 | RSS: Main: 203288576 11:44:35 INFO - PID 17618 | 11:44:38 INFO - PID 17618 | Cycle 1(1): loaded http://localhost:39913/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39913/tests/kraken/driver.html?testName=imaging-darkroom) 11:44:38 INFO - PID 17618 | RSS: Main: 205545472 11:44:38 INFO - PID 17618 | 11:44:42 INFO - PID 17618 | Cycle 1(1): loaded http://localhost:39913/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39913/tests/kraken/driver.html?testName=imaging-desaturate) 11:44:43 INFO - PID 17618 | RSS: Main: 204001280 11:44:43 INFO - PID 17618 | 11:44:46 INFO - PID 17618 | Cycle 1(1): loaded http://localhost:39913/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39913/tests/kraken/driver.html?testName=json-parse-financial) 11:44:46 INFO - PID 17618 | RSS: Main: 206151680 11:44:46 INFO - PID 17618 | 11:44:48 INFO - PID 17618 | Cycle 1(1): loaded http://localhost:39913/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39913/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:44:49 INFO - PID 17618 | RSS: Main: 206295040 11:44:49 INFO - PID 17618 | 11:44:50 INFO - PID 17618 | Cycle 1(1): loaded http://localhost:39913/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39913/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:44:51 INFO - PID 17618 | RSS: Main: 202702848 11:44:51 INFO - PID 17618 | 11:44:53 INFO - PID 17618 | Cycle 1(1): loaded http://localhost:39913/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39913/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:44:54 INFO - PID 17618 | RSS: Main: 203747328 11:44:54 INFO - PID 17618 | 11:44:56 INFO - PID 17618 | Cycle 1(1): loaded http://localhost:39913/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39913/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:44:57 INFO - PID 17618 | RSS: Main: 203034624 11:44:57 INFO - PID 17618 | 11:45:00 INFO - PID 17618 | Cycle 1(1): loaded http://localhost:39913/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39913/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:45:01 INFO - PID 17618 | RSS: Main: 202641408 11:45:01 INFO - PID 17618 | 11:45:02 INFO - PID 17618 | Cycle 1(1): loaded http://localhost:39913/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39913/tests/kraken/driver.html?testName=ai-astar) 11:45:03 INFO - PID 17618 | RSS: Main: 205881344 11:45:03 INFO - PID 17618 | 11:45:03 INFO - PID 17618 | __start_tp_report 11:45:03 INFO - PID 17618 | _x_x_mozilla_page_load 11:45:03 INFO - PID 17618 | _x_x_mozilla_page_load_details 11:45:03 INFO - PID 17618 | |i|pagename|runs| 11:45:03 INFO - PID 17618 | |0;ai-astar;116;112;111;109;114;107;108;114;118;109 11:45:03 INFO - PID 17618 | |1;audio-beat-detection;118;123;127;115;123;138;125;123;131;152 11:45:03 INFO - PID 17618 | |2;audio-dft;172;168;164;161;169;167;170;169;167;163 11:45:03 INFO - PID 17618 | |3;audio-fft;74;73;75;77;75;80;74;73;78;75 11:45:03 INFO - PID 17618 | |4;audio-oscillator;80;85;82;83;85;79;89;81;89;89 11:45:03 INFO - PID 17618 | |5;imaging-gaussian-blur;111;123;115;109;114;114;115;117;116;124 11:45:03 INFO - PID 17618 | |6;imaging-darkroom;149;157;149;149;148;148;149;150;158;151 11:45:03 INFO - PID 17618 | |7;imaging-desaturate;99;94;99;94;95;99;95;95;95;96 11:45:03 INFO - PID 17618 | |8;json-parse-financial;55;56;56;57;54;55;58;55;55;59 11:45:03 INFO - PID 17618 | |9;json-stringify-tinderbox;44;43;49;48;38;39;42;39;38;38 11:45:03 INFO - PID 17618 | |10;stanford-crypto-aes;74;76;73;74;78;79;79;76;73;79 11:45:03 INFO - PID 17618 | |11;stanford-crypto-ccm;111;114;118;118;127;115;115;123;120;117 11:45:03 INFO - PID 17618 | |12;stanford-crypto-pbkdf2;170;168;180;169;174;171;177;175;180;175 11:45:03 INFO - PID 17618 | |13;stanford-crypto-sha256-iterative;72;68;65;63;65;64;67;65;67;64 11:45:03 INFO - PID 17618 | __end_tp_report 11:45:03 INFO - PID 17618 | __start_cc_report 11:45:03 INFO - PID 17618 | _x_x_mozilla_cycle_collect,745 11:45:03 INFO - PID 17618 | __end_cc_report 11:45:03 INFO - PID 17618 | __startTimestamp1505760303221__endTimestamp 11:45:03 INFO - PID 17618 | 11:45:03 INFO - PID 17618 | ------- Summary: start ------- 11:45:03 INFO - PID 17618 | Number of tests: 14 11:45:03 INFO - PID 17618 | 11:45:03 INFO - PID 17618 | [#0] ai-astar Cycles:10 Average:111.80 Median:113.00 stddev:3.65 (3.2%) stddev-sans-first:3.54 11:45:03 INFO - PID 17618 | Values: 116.0 112.0 111.0 109.0 114.0 107.0 108.0 114.0 118.0 109.0 11:45:03 INFO - PID 17618 | 11:45:03 INFO - PID 17618 | [#1] audio-beat-detection Cycles:10 Average:127.50 Median:126.00 stddev:10.73 (8.5%) stddev-sans-first:10.82 11:45:03 INFO - PID 17618 | Values: 118.0 123.0 127.0 115.0 123.0 138.0 125.0 123.0 131.0 152.0 11:45:03 INFO - PID 17618 | 11:45:03 INFO - PID 17618 | [#2] audio-dft Cycles:10 Average:167.00 Median:168.50 stddev:3.40 (2.0%) stddev-sans-first:3.09 11:45:03 INFO - PID 17618 | Values: 172.0 168.0 164.0 161.0 169.0 167.0 170.0 169.0 167.0 163.0 11:45:03 INFO - PID 17618 | 11:45:03 INFO - PID 17618 | [#3] audio-fft Cycles:10 Average:75.40 Median:75.00 stddev:2.27 (3.0%) stddev-sans-first:2.35 11:45:03 INFO - PID 17618 | Values: 74.0 73.0 75.0 77.0 75.0 80.0 74.0 73.0 78.0 75.0 11:45:03 INFO - PID 17618 | 11:45:03 INFO - PID 17618 | [#4] audio-oscillator Cycles:10 Average:84.20 Median:85.00 stddev:3.82 (4.5%) stddev-sans-first:3.74 11:45:03 INFO - PID 17618 | Values: 80.0 85.0 82.0 83.0 85.0 79.0 89.0 81.0 89.0 89.0 11:45:03 INFO - PID 17618 | 11:45:03 INFO - PID 17618 | [#5] imaging-gaussian-blur Cycles:10 Average:115.80 Median:115.50 stddev:4.69 (4.1%) stddev-sans-first:4.64 11:45:03 INFO - PID 17618 | Values: 111.0 123.0 115.0 109.0 114.0 114.0 115.0 117.0 116.0 124.0 11:45:03 INFO - PID 17618 | 11:45:03 INFO - PID 17618 | [#6] imaging-darkroom Cycles:10 Average:150.80 Median:149.50 stddev:3.65 (2.4%) stddev-sans-first:3.81 11:45:03 INFO - PID 17618 | Values: 149.0 157.0 149.0 149.0 148.0 148.0 149.0 150.0 158.0 151.0 11:45:03 INFO - PID 17618 | 11:45:03 INFO - PID 17618 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:95.50 stddev:2.08 (2.2%) stddev-sans-first:1.92 11:45:03 INFO - PID 17618 | Values: 99.0 94.0 99.0 94.0 95.0 99.0 95.0 95.0 95.0 96.0 11:45:03 INFO - PID 17618 | 11:45:03 INFO - PID 17618 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:56.00 stddev:1.56 (2.8%) stddev-sans-first:1.62 11:45:03 INFO - PID 17618 | Values: 55.0 56.0 56.0 57.0 54.0 55.0 58.0 55.0 55.0 59.0 11:45:03 INFO - PID 17618 | 11:45:03 INFO - PID 17618 | [#9] json-stringify-tinderbox Cycles:10 Average:41.80 Median:42.50 stddev:4.16 (9.8%) stddev-sans-first:4.33 11:45:03 INFO - PID 17618 | Values: 44.0 43.0 49.0 48.0 38.0 39.0 42.0 39.0 38.0 38.0 11:45:03 INFO - PID 17618 | 11:45:03 INFO - PID 17618 | [#10] stanford-crypto-aes Cycles:10 Average:76.10 Median:77.00 stddev:2.51 (3.3%) stddev-sans-first:2.55 11:45:03 INFO - PID 17618 | Values: 74.0 76.0 73.0 74.0 78.0 79.0 79.0 76.0 73.0 79.0 11:45:03 INFO - PID 17618 | 11:45:03 INFO - PID 17618 | [#11] stanford-crypto-ccm Cycles:10 Average:117.80 Median:118.00 stddev:4.64 (3.9%) stddev-sans-first:4.22 11:45:03 INFO - PID 17618 | Values: 111.0 114.0 118.0 118.0 127.0 115.0 115.0 123.0 120.0 117.0 11:45:03 INFO - PID 17618 | 11:45:03 INFO - PID 17618 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.90 Median:175.00 stddev:4.33 (2.5%) stddev-sans-first:4.36 11:45:03 INFO - PID 17618 | Values: 170.0 168.0 180.0 169.0 174.0 171.0 177.0 175.0 180.0 175.0 11:45:03 INFO - PID 17618 | 11:45:03 INFO - PID 17618 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:66.00 stddev:2.62 (4.0%) stddev-sans-first:1.66 11:45:03 INFO - PID 17618 | Values: 72.0 68.0 65.0 63.0 65.0 64.0 67.0 65.0 67.0 64.0 11:45:03 INFO - PID 17618 | -------- Summary: end -------- 11:45:03 INFO - PID 17618 | 11:45:03 INFO - PID 17618 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:45:04 INFO - TEST-INFO | 17618: exit 0 11:45:04 INFO - TEST-OK | kraken | took 63000ms 11:45:04 INFO - SUITE-END | took 1176s 11:45:04 INFO - Completed test suite (00:19:36) 11:45:04 INFO - javascript benchmark 11:45:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8485.972707333776, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3100.984495077524, 3110.5800716903213, 3132.843357832109, 3157.9210519737003, 3158.952615710765, 6183.969080154593, 6240.219972503437, 6301.338359472258, 6344.0, 6387.48900087993, 6053.939460605393, 6087.665178415185, 6112.1137435072, 6123.326434092246, 6123.632582045069, 5637.689927054011, 5649.039663257236, 5649.4633009864, 5661.631993920402, 5702.372738998728, 5830.970845145768, 5839.153322768196, 5853.297604287492, 5864.853378665546, 5878.0, 5740.483356497914, 5871.0, 5899.2920849497905, 5904.143899134623, 5929.466348028676, 5588.105903055492, 5642.153676948449, 5696.2594862668, 5774.076147816371, 5853.560982926277, 5665.830025099253, 5757.712114394305, 5769.480746732815, 5777.768889244425, 5800.796972105998, 6176.907346389808, 6188.195534580521, 6189.288231853305, 6281.403266689657, 6384.3934826191435, 6581.276059633485, 6625.602463852184, 6648.434883034948, 6680.365365290289, 6688.765893193715, 6657.567258128206, 6667.233268174125, 6691.59850408977, 6701.329867013308, 6726.730930762764, 6187.288461826903, 6217.720202590849, 6253.96873015632, 6304.968475157595, 6333.746650134035, 6966.58200507961, 6980.197277313073, 7047.224805271416, 7055.682494287769, 7082.681279342339, 6646.700898459581, 6674.966625166843, 6724.226713927863, 6724.7646332378135, 6748.156480439945, 6606.372394622503, 6683.933160668428, 6714.563553369016, 6716.093327400738, 6739.460843132538, 6673.265940746514, 6702.530822842355, 6706.329367063352, 6709.563878347892, 6791.219009813836, 6724.125863637696, 6759.729610815611, 6780.355866192704, 6788.151481064867, 6816.284290149562, 5267.920981185285, 5295.887863548698, 5335.893282134336, 5338.706371149624, 5345.278387417648, 4545.5908968193025, 4613.215753321943, 4620.8151673933335, 4635.026644404646, 4637.327587499861, 5693.60144789869, 5697.515711164598, 5713.685747283939, 5718.428157184248, 5730.77076916927, 6661.833454163685, 6676.732930682719, 6727.091842601284, 6755.459563234929, 6807.761728339485, 5756.827295181151, 5763.7406316715005, 5802.941970580325, 5820.039693450533, 5827.446392592697, 5749.3963133871175, 5771.769129234784, 5820.185174075633, 5849.181114643953, 5866.970665146732, 6452.4515416189215, 6506.25178104524, 6573.5398522103, 6576.342365763386, 6605.504587155887, 6532.869342613026, 6600.1089852869245, 6726.697298621476, 6809.93190068093, 6815.420689241271, 6407.391297826699, 6510.5117116217425, 6521.282658907611, 6546.0, 6575.835604109936, 6654.13496245485, 6733.595984240961, 6761.290064543349, 6774.593524388552, 6778.3221677831825, 6688.030235615905, 6695.263521012782, 6733.865322693617, 6790.5925644461495, 6841.726330946706, 6365.204349456318, 6463.095166676763, 6492.707828147651, 6539.149910511794, 6596.076549283008, 6498.837529061811, 6499.805005849832, 6581.572197807127, 6582.670866456562, 6613.537052406477, 6454.967725161344, 6466.935330646634, 6502.577332473374, 6521.804345869631, 6535.934640653532, 6509.0, 6582.275949645631, 6621.0, 6659.0, 6673.432758215606, 6200.782972595937, 6280.246370435394, 6321.5574909757715, 6400.359964003563, 6413.4869210463985], "value": 6118.384153780491, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [781.2382926646524, 786.9213078692131, 816.705985845096, 821.6302663801291, 829.7220431155566, 39003.60996390035, 39779.801100994526, 39931.80034099833, 40063.39904901425, 40207.0, 36054.0, 36393.090172745695, 36563.26873462529, 36577.634223657755, 36595.451068234, 6805.591664500133, 6897.0, 6897.931020689804, 6927.203371612279, 6948.096747422828, 6798.0, 6896.586204827701, 6902.6203558804245, 6903.930960690379, 6916.723331066752, 6874.037634731141, 6906.896396554056, 7523.623818809065, 7677.884831727529, 7689.0, 7551.848963020736, 7565.432592555553, 7604.885926711104, 7659.195784442609, 7681.193474685189, 7381.261873812629, 7579.696812127509, 7586.355159811423, 7591.848163036709, 7604.201558836297, 36936.261274774624, 36993.0, 37526.624733752586, 37619.24761504755, 37671.0, 3354.8490317935753, 3379.2396710739886, 3380.8985730428126, 3416.974907527732, 3419.2135808763874, 29126.41747165045, 29205.41589168205, 29269.0, 29442.263943401587, 29498.0, 5073.365829271341, 5076.847694569169, 5109.080365534202, 5143.614228932807, 5216.660917040418, 173857.1307143469, 185088.0, 190359.0, 191356.0, 193938.9999999986, 46951.765241173576, 46969.0, 47148.764256178496, 47232.7638361806, 47395.28907066397, 48528.0, 48946.51053489491, 49026.26460603094, 49184.50815491871, 49190.262146067835, 15388.230588470531, 15492.5352239433, 15502.689946201013, 15565.143917084442, 15656.608584785243, 12739.61781146567, 12766.872331276754, 12782.360881955865, 12814.615561533168, 12859.035572331926, 13452.260125692985, 13661.931690341484, 13777.0, 13813.51652692151, 13942.790858137136, 5594.517452874991, 5645.943540564624, 5681.602287839812, 5739.65562066269, 5801.767929282782, 995.6913356859396, 1004.1013293102632, 1009.0817356205818, 1016.7102375823002, 1018.8420794776821, 21804.0, 21876.343709688736, 22504.662430063563, 22563.77436225617, 22686.773132268798, 1074.414444127952, 1088.8638920134983, 1090.5038207615517, 1108.3516143056402, 1117.9664610061711, 11761.235519691192, 11783.351915644722, 11824.23142495735, 11868.525258989717, 11947.402629868646, 213485.0, 213685.0, 213945.0, 215535.0, 215734.0, 50626.49373506291, 51070.23394649083, 51406.74296628493, 51427.48572514227, 51459.0, 1359.3746876436753, 1422.679897023182, 1429.5711286614182, 1440.8703216710337, 1450.470578238935, 21751.564968700222, 21865.739144340358, 21871.0, 21880.12479500802, 22056.228032018804, 35269.64730352664, 35521.82239088891, 35583.82208088943, 35596.644033559336, 35620.82189589035, 138191.30904345415, 138485.3075734615, 138883.0, 138886.0, 139118.0, 29826.403471930007, 30122.849385752932, 32141.196470088435, 32351.352972939938, 32743.836280818443, 40767.18465630611, 40999.59000409958, 41007.79496102501, 41492.79253603713, 41753.58246417497, 30164.5475317866, 30654.693453065185, 30724.539131913487, 30848.074557763302, 31106.377872442878, 30008.849955750953, 30269.0, 30290.24274393158, 31269.218269543442, 31592.0, 33766.98699039033, 34038.0, 34116.0, 34348.0, 34400.82799585986, 29518.262043449085, 29741.553876691432, 29773.404531909673, 30186.396272073995, 30760.692393075784, 21822.236221732164, 22583.548329032998, 22869.656955145354, 22876.08495660155, 23163.76836231616], "value": 16279.355332713656, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [546.9617126801126, 554.6644280210472, 556.73276827123, 571.9513841323487, 597.1669521018179, 21405.250816221436, 22151.446213844643, 22322.77677223227, 22345.44136396591, 22419.55160896781, 23849.880750596265, 24055.63916541249, 24350.0, 24881.502369952592, 25211.0, 6439.742410303594, 6523.9673801630925, 6558.2130144382745, 6617.536772425932, 6623.801285961429, 6403.455706264973, 6422.293547709748, 6492.766374388874, 6506.512011599125, 6507.51193660475, 6114.2968558615885, 6329.556931014831, 6347.270063942637, 6363.490920726331, 6408.807735767911, 6310.085037669535, 6357.2371315442215, 6375.968120159369, 6376.36236376361, 6384.93615063848, 5903.763849446017, 5916.763329466816, 5930.318013428468, 5949.732262048218, 6110.08348747687, 28451.85774071137, 28954.855225723946, 28984.27539311513, 29073.709262907312, 29073.709262907523, 2060.958780824375, 2088.976401563238, 2089.3209706845337, 2089.6447603907222, 2095.245711543843, 18801.0, 19144.23423063076, 19263.651544391898, 19324.1304141314, 19439.708404373945, 2416.4683769570665, 2429.4248097017044, 2448.951020979588, 2469.9135530256535, 2475.5048990201853, 114301.0, 117795.05512362174, 117942.0, 132391.0, 136184.0, 19931.800681993285, 20727.27454539084, 20764.792352076587, 22008.669869951962, 22257.554848903255, 41713.58286417097, 41733.79133104376, 41786.373204401956, 41799.164016720104, 42154.0, 10167.796644067077, 10183.949080254552, 10212.08091271789, 10236.181105511541, 10316.123129534073, 8333.416650836321, 8388.580570971428, 8408.117147699526, 8475.915240847637, 8545.957270213608, 10752.892471075345, 11090.168237382228, 11140.610078647209, 11275.718107047389, 11306.208565400508, 3966.167104907944, 4260.25445547028, 4267.679924005712, 4360.171567402183, 4468.352088947149, 930.7161315798611, 942.6936245720168, 961.3462845265148, 965.5510187762724, 969.1229437359201, 18805.341813036477, 18847.340343087926, 19367.51581210481, 19434.70847937282, 19565.608687826447, 1009.9444530550891, 1014.1886490807325, 1021.8927012663712, 1029.9691009269734, 1032.390889375272, 10491.68524944253, 10542.367457952547, 10630.362178269328, 10710.678679639623, 10819.13446924244, 443210.70431978937, 455876.0, 459015.0, 460237.0, 465516.0, 111577.44211278892, 113346.43326783313, 113545.0, 114055.42972285085, 114656.42671786588, 1023.518946095334, 1066.722652110457, 1133.1897693149274, 1164.6447833410891, 1185.3954483213622, 20525.794742052985, 20608.793912061286, 20622.896885515478, 20745.792542074385, 20771.376858694264, 57972.13041804461, 59277.407225927185, 59463.70268148631, 59824.0, 60032.699836500535, 73043.63478182575, 73464.26535734574, 73711.26288737259, 73871.0, 74577.25422745703, 19819.207231711145, 20407.4898127548, 20454.0, 20554.075066622336, 20836.166553337698, 22276.554468910206, 22341.441463963532, 22350.105995759986, 22530.66204006974, 22635.886820565793, 17530.0, 18134.54663633367, 18188.36340728068, 18364.989925554222, 18437.354692585694, 16491.91754041222, 16917.238724257193, 16942.745858811882, 16949.74575381395, 16976.74534881953, 18190.181441834884, 18401.3559525416, 18791.34230301933, 18803.71794423112, 18881.150348234638, 19775.802241977395, 19833.30583429573, 20115.497112572302, 20181.39455816328, 20278.79721202769, 18087.728684069487, 18280.268789248814, 18317.08414579239, 18339.816601833812, 18385.080745962914], "value": 12583.438512729856, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1316.9473221071157, 1406.3952500424816, 1409.4362255097965, 1410.7954346619747, 1415.9150450972936, 14647.926760366197, 15402.075875447466, 15437.536873893772, 15464.458743943964, 15481.225938703075, 14932.925335373335, 15045.92477037616, 15099.169545674984, 15145.167015814126, 15197.316120774563, 2635.3279913622, 2702.6216329713807, 2715.0, 2717.91846244613, 2738.411241583059, 2692.892284308635, 2760.627315312427, 2780.88876444942, 2789.0377819652185, 2794.119852246546, 2703.999520177537, 2706.066407089551, 2741.0954385052983, 2820.125761014082, 2822.717728227171, 2746.368335282896, 2749.285185851673, 2774.3202915285683, 2775.597538356947, 2783.498970185366, 2590.961135582968, 2668.7064422913463, 2678.08944958715, 2679.5712685970348, 2680.437108207279, 14808.481703140445, 15232.162231077285, 15246.542603721795, 15291.617709557238, 15322.540323790192, 7829.3736501079775, 8136.674533018672, 8141.43009989301, 8145.266925976691, 8149.755507334789, 5345.786168553253, 5556.749946252428, 5687.772489100431, 5688.97155514224, 5732.570057245724, 1691.205133587212, 1746.9475915722549, 1747.3971479839563, 1777.742227377036, 1788.9642207155784, 25671.48657026849, 26068.34829129268, 26080.34799130018, 26136.085237016803, 26219.0, 6839.692213850389, 6878.38094571491, 6879.105716256855, 6979.616121113286, 7088.716451341992, 16966.15169241533, 17008.744868826976, 17020.404285849934, 17044.829551704574, 17078.829211707725, 7653.311201991847, 7911.604419778988, 7914.683412663429, 7926.801829954182, 7938.801529961797, 7155.7495487658725, 7174.641267936687, 7311.780646580611, 7366.116066072105, 7427.294407031323, 4894.094592500328, 5031.7987280509105, 5035.295058691786, 5053.722045287471, 5064.46823083571, 1421.644588852787, 1442.228407801821, 1458.4457905995653, 1461.2474575593578, 1472.7717203833422, 880.4365206267994, 896.9819255145457, 909.3361845852432, 915.0483497162876, 932.4032619123766, 8072.192780721881, 8137.349012079019, 8152.38857085721, 8165.428420010542, 8187.140350263256, 974.7855471796194, 997.581015973293, 1006.808706345792, 1006.9748256293651, 1009.4246279620546, 5190.844274671766, 5274.868128296824, 5315.521603055666, 5344.5724342052545, 5368.114261146945, 21268.468288292916, 21273.255436059662, 21403.67894481584, 21901.123955041938, 22102.77897221007, 20324.390268291976, 20744.377668669964, 21427.357179284645, 21453.356399307733, 21700.240491582717, 10849.945750271356, 11145.164112691418, 11170.106391488662, 11171.44142792857, 11176.217664763552, 7907.327877130509, 8266.875996859932, 8387.622556985072, 8394.412391132806, 8462.407631465738, 17394.0, 17657.646847063243, 18658.44024679262, 19016.0, 19202.13590388408, 18612.25550978, 19111.331103411314, 19437.31969381065, 19472.61054778925, 19508.0, 11099.389533575732, 11281.887181128084, 11316.094712423152, 11328.433578321215, 11349.48927298257, 13639.79540306916, 13644.590662280147, 13812.516561920285, 13947.093438926437, 13955.58133256004, 11242.0, 11578.478968446272, 11612.94193529027, 11627.186096973131, 11786.882131178578, 11336.886631133913, 11365.772684546428, 11400.828987565028, 11491.482883270106, 11504.53981840717, 9618.326717129734, 9744.658936937172, 9751.707448776548, 9828.606855725691, 9852.014798520091, 7097.503174777716, 7118.822029449098, 7135.215126335995, 7168.426525877813, 7221.602811845399, 6950.374466298057, 7271.291246556949, 7327.560346379234, 7357.117145942521, 7385.778426647209], "value": 6665.246606354632, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [487.0939285851263, 494.7655938645178, 512.2725729464161, 521.2051621277551, 523.4765234765234, 6278.2779980302275, 6341.873162536758, 6368.904466433001, 6388.520860935437, 6388.64862432566, 6213.130161777343, 6293.27627322858, 6317.557770956023, 6336.841578960528, 6352.428281454668, 5203.4536373680785, 5225.973870130644, 5232.189010703347, 5234.607404444682, 5245.816396426126, 5151.716655583941, 5161.535461808437, 5236.345456817898, 5271.789128434858, 5318.46815318467, 4862.44081930579, 4965.808206030562, 4966.108383242503, 4988.678000329915, 5021.899562008758, 4869.82955596556, 4931.901361972777, 4956.157453232941, 4999.525045120708, 5025.673331233476, 4431.423914891044, 4467.3299005149165, 4470.575295346936, 4477.820887164509, 4485.170243504962, 6110.297315808694, 6111.816645500642, 6172.321044685081, 6201.503879689614, 6210.130581718563, 5705.714714264312, 5729.742161602696, 5748.137779333092, 5749.170696614864, 5766.538676905838, 6558.93441065588, 6589.439897608709, 6643.501737369668, 6659.733610655568, 6713.328667133248, 4633.582977532004, 4772.665913386064, 4840.128776820171, 4842.854714358575, 4877.0, 6690.966545167243, 6825.658717064177, 6845.212800527953, 6889.414399775975, 6918.06606108179, 4968.739223653229, 4999.400071991385, 5003.2995380646735, 5031.823886163967, 5045.789010637421, 5074.644774865724, 5089.9745501272255, 5112.284280200774, 5121.231815227671, 5124.5131712487255, 5669.546436285087, 5672.376038635747, 5690.95125754728, 5721.8569535761935, 5737.221461346912, 6606.669666516655, 6637.601743895381, 6671.43292820106, 6726.6636668167375, 6726.932730672631, 1751.6234009687978, 1753.7460715588415, 1773.3349993752342, 1776.1829558403278, 1783.839454449106, 1141.8743938166795, 1212.7635111153418, 1213.1811027556364, 1225.8590262119792, 1227.245244174826, 5588.608797384144, 5647.29408823897, 5692.743826527816, 5696.430356964353, 5733.541316694655, 6673.766418175341, 6697.7655782047395, 6731.259561448237, 6769.661516924134, 6779.15260592426, 5577.075908811454, 5647.858803529863, 5653.971730141323, 5660.0, 5679.6876171810945, 3546.6453354664845, 3574.303010912899, 3581.5344005279667, 3587.1390866191928, 3621.8189090545366, 6363.09107267827, 6401.583897046677, 6456.870862582722, 6484.935150648527, 6552.475801935833, 6753.602471122779, 6834.1457317835275, 6846.486513511507, 6866.759663411756, 6940.861182776417, 5887.470127688529, 6390.297067322591, 6463.030545418131, 6489.7404103835315, 6507.511936604868, 6534.934650653433, 6536.182977127859, 6558.967205163944, 6635.502337324817, 6664.500162487736, 6577.375149360803, 6608.8347791305605, 6629.138212032405, 6677.0, 6683.43190828785, 6342.23893132827, 6366.2360516736435, 6446.8388290293115, 6461.19235095613, 6564.901526477011, 4984.975075124601, 5000.67495612784, 5008.398992120969, 5009.649324547247, 5018.498150185098, 6500.3174666659315, 6617.437517810848, 6635.469162467088, 6795.490338224752, 6814.216365117876, 6475.514336424882, 6528.89008868503, 6569.211694596679, 6607.372299631527, 6614.66926653675, 6488.935110648833, 6497.220333559814, 6542.149520562297, 6555.4427873631275, 6574.342565743387, 6425.678716064084, 6461.741530338733, 6475.708593113415, 6509.4792416605615, 6532.444742196966, 6584.0, 6589.505787066085, 6636.668166591555, 6668.0, 6695.933040669531, 6277.937220627918, 6333.1766870306565, 6418.614883107029, 6434.64609446485, 6488.740450381932], "value": 5065.705636753261, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [926.1849572376312, 928.3130483442254, 937.3860121620341, 943.5140902435243, 953.6280850468316, 18159.636807263847, 18607.62784744306, 18643.627127457443, 18648.06759662015, 18707.532311692197, 17888.28446862124, 17957.461276161703, 18049.0, 18169.454916352497, 18213.544661383472, 970.0784254957783, 987.146118607403, 989.9950500247488, 993.3692105513015, 994.0854413939194, 986.0927946289395, 986.6941248213041, 988.9258305627106, 991.4051569058579, 994.1500017485055, 984.4339504784741, 1031.046282188976, 1046.785408991155, 1047.842823576462, 1048.6120135549857, 1030.644427672452, 1031.020530496028, 1038.7247379444452, 1041.3751748950683, 1042.067349722002, 754.9433792465533, 757.307064036406, 757.5530437042172, 757.7158565537924, 757.9696812127509, 19285.132169052427, 19422.611547769106, 19503.90248048765, 19533.609327813505, 19562.217511299532, 21300.36098917035, 21409.357719268446, 21423.67864482034, 21533.138674453003, 21537.56924861494, 16363.59091022722, 16654.58363540909, 16680.83319166817, 16718.0, 16874.83125168745, 3726.5528136623507, 3748.137928276484, 3759.3233218020746, 3760.9623903760885, 3761.680257178143, 123919.0, 133083.33458332648, 137452.999999999, 137834.0, 139216.0, 17028.233729482203, 17884.0, 17939.0, 17969.550761231072, 17975.910120449313, 31134.844325778227, 31426.685733142833, 31737.206569835478, 31889.043328700176, 31906.0, 8570.142985701379, 8826.602802873886, 8957.552122393985, 8971.551422428853, 9019.594118264693, 3642.61752515982, 3746.7939263340777, 3768.9434658480145, 3778.8299526521373, 3789.6778773804535, 5384.5692344612335, 5386.461353864583, 5386.461353864661, 5396.379416367089, 5399.379071406838, 1088.080571916729, 1129.5707631100129, 1132.28665940457, 1134.3647557367901, 1142.114860982745, 616.5961295351552, 653.8953767397194, 654.9115869357671, 662.9933700662932, 667.219353356574, 11764.35296058725, 11834.822477662841, 12207.694807629703, 12225.449854756558, 12587.559435419716, 654.6006935769177, 663.2041550139852, 665.7303791964263, 666.7899611622323, 671.7145213284334, 5407.215953686772, 5483.8080667177255, 5492.47821456961, 5589.74846131925, 5609.326880774333, 121631.0, 122289.38855305666, 122650.0, 126648.0, 126994.0, 107890.0, 109239.0, 109675.0, 110325.44837275923, 111053.0, 92523.0, 93474.53262733643, 95413.52293238629, 99245.0, 99847.0, 9943.353682010646, 10023.849642255225, 10026.298159128792, 10194.235432342752, 10202.795944081225, 43443.56556434395, 43686.0, 44008.33987490126, 45635.77182114068, 45831.0, 55666.16500752573, 56041.0, 56280.0, 57238.0, 57717.483635637174, 15233.086014839146, 15297.77053344223, 15345.769813452584, 15365.308561115, 15491.147986860831, 16853.325866965184, 17271.222794974507, 17274.136293185038, 17372.218250179027, 17546.21042053085, 13579.456821727415, 13818.96357773191, 13832.446702131801, 14124.576262712135, 14167.079139856289, 15098.169600671628, 15485.070895746292, 15488.5353439397, 15575.688486230438, 15652.452164174654, 15045.473408430653, 15130.394784208509, 15166.317515711598, 15196.848031519985, 15516.069035857885, 11566.65300041, 11659.825102623297, 11746.412679365827, 11922.105842061706, 12046.638600841989, 11240.15698822608, 11240.437978101227, 11413.144014198802, 11438.313701177956, 11461.885381146081], "value": 8823.789279347708, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1460.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 112.0, 111.0, 109.0, 114.0, 107.0, 108.0, 114.0, 118.0, 109.0], "value": 111.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 123.0, 127.0, 115.0, 123.0, 138.0, 125.0, 123.0, 131.0, 152.0], "value": 127.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 168.0, 164.0, 161.0, 169.0, 167.0, 170.0, 169.0, 167.0, 163.0], "value": 167.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 75.0, 77.0, 75.0, 80.0, 74.0, 73.0, 78.0, 75.0], "value": 75.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 85.0, 82.0, 83.0, 85.0, 79.0, 89.0, 81.0, 89.0, 89.0], "value": 84.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 123.0, 115.0, 109.0, 114.0, 114.0, 115.0, 117.0, 116.0, 124.0], "value": 115.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 157.0, 149.0, 149.0, 148.0, 148.0, 149.0, 150.0, 158.0, 151.0], "value": 150.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 94.0, 99.0, 94.0, 95.0, 99.0, 95.0, 95.0, 95.0, 96.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 56.0, 57.0, 54.0, 55.0, 58.0, 55.0, 55.0, 59.0], "value": 56.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [44.0, 43.0, 49.0, 48.0, 38.0, 39.0, 42.0, 39.0, 38.0, 38.0], "value": 41.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 73.0, 74.0, 78.0, 79.0, 79.0, 76.0, 73.0, 79.0], "value": 76.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 114.0, 118.0, 118.0, 127.0, 115.0, 115.0, 123.0, 120.0, 117.0], "value": 117.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 168.0, 180.0, 169.0, 174.0, 171.0, 177.0, 175.0, 180.0, 175.0], "value": 173.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 68.0, 65.0, 63.0, 65.0, 64.0, 67.0, 65.0, 67.0, 64.0], "value": 66.0, "unit": "score"}]}]} 11:45:04 INFO - Return code: 0 11:45:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:45:04 INFO - # TBPL SUCCESS # 11:45:04 INFO - Running post-action listener: _package_coverage_data 11:45:04 INFO - Running post-action listener: _resource_record_post_action 11:45:04 INFO - [mozharness: 2017-09-18 18:45:04.534469Z] Finished run-tests step (success) 11:45:04 INFO - Running post-run listener: _resource_record_post_run 11:45:04 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 294912; Write bytes: 341708800; Read time: 300; Write time: 224548 11:45:04 INFO - TinderboxPrint: CPU usage
13.3% 11:45:04 INFO - TinderboxPrint: I/O read bytes / time
294,912 / 300 11:45:04 INFO - TinderboxPrint: I/O write bytes / time
341,708,800 / 224,548 11:45:04 INFO - TinderboxPrint: CPU idle
8,256.5 (86.7%) 11:45:04 INFO - TinderboxPrint: CPU user
1,201.9 (12.6%) 11:45:04 INFO - TinderboxPrint: Swap in / out
0 / 0 11:45:04 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 10223616; Read time: 0; Write time: 704 11:45:04 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:45:04 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 290816; Write bytes: 331485184; Read time: 288; Write time: 223844 11:45:05 INFO - Running post-run listener: _upload_blobber_files 11:45:05 INFO - Blob upload gear active. 11:45:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:45:05 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 11:45:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:45:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:45:05 INFO - (blobuploader) - INFO - Open directory for files ... 11:45:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:45:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:45:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:45:06 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:45:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:45:06 INFO - (blobuploader) - INFO - Done attempting. 11:45:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:45:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:45:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:45:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:45:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:45:07 INFO - (blobuploader) - INFO - Done attempting. 11:45:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:45:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:45:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:45:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:45:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:45:13 INFO - (blobuploader) - INFO - Done attempting. 11:45:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:45:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:45:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:45:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:45:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:45:14 INFO - (blobuploader) - INFO - Done attempting. 11:45:14 INFO - (blobuploader) - INFO - Iteration through files over. 11:45:14 INFO - Return code: 0 11:45:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:45:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:45:14 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/30344cc478ddd504dd900e1e79168da0c8a02a27ed6bdf4cad22cbb0beff50ac875cd2d19cbdc2f55e1450b0e396af57466268bb881283cd7334f9a7d1f71729", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/50dc48b8e912d179c5f88fac19c9cd835a29e86d8b088756d7299668d72f979ba32726044ac134fe39d2edef472087e047a6194c36fe555d415e3d3d25caf926", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0e000366b93bc8273d134000452e1bfdc643927f2cdb1a58ebd4a271871810533b22857cb8a230c941fabc41d1a02ea5d6587dc094e2aa8b7367ed2e658c95d2", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1ddbd25eaea325924e7b87bb3a6b74d0989d61c00f016342243f3703ef56f39a852936b4132ddcb8b7026a1e8ad68a24b343380f9477b0087f65eebdd30498bb"} 11:45:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:45:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:45:14 INFO - Contents: 11:45:14 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/30344cc478ddd504dd900e1e79168da0c8a02a27ed6bdf4cad22cbb0beff50ac875cd2d19cbdc2f55e1450b0e396af57466268bb881283cd7334f9a7d1f71729", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/50dc48b8e912d179c5f88fac19c9cd835a29e86d8b088756d7299668d72f979ba32726044ac134fe39d2edef472087e047a6194c36fe555d415e3d3d25caf926", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0e000366b93bc8273d134000452e1bfdc643927f2cdb1a58ebd4a271871810533b22857cb8a230c941fabc41d1a02ea5d6587dc094e2aa8b7367ed2e658c95d2", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1ddbd25eaea325924e7b87bb3a6b74d0989d61c00f016342243f3703ef56f39a852936b4132ddcb8b7026a1e8ad68a24b343380f9477b0087f65eebdd30498bb"} 11:45:14 INFO - Running post-run listener: copy_logs_to_upload_dir 11:45:14 INFO - Copying logs to upload dir... 11:45:14 INFO - mkdir: /builds/slave/test/build/upload/logs 11:45:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.499119 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2017-09-18 11:45:14.913102) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-18 11:45:14.916755) ========= 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=dbb0bb31bf4a4c7db9ba1648000001b6-1505753956.465478-1105325866 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/30344cc478ddd504dd900e1e79168da0c8a02a27ed6bdf4cad22cbb0beff50ac875cd2d19cbdc2f55e1450b0e396af57466268bb881283cd7334f9a7d1f71729", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/50dc48b8e912d179c5f88fac19c9cd835a29e86d8b088756d7299668d72f979ba32726044ac134fe39d2edef472087e047a6194c36fe555d415e3d3d25caf926", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0e000366b93bc8273d134000452e1bfdc643927f2cdb1a58ebd4a271871810533b22857cb8a230c941fabc41d1a02ea5d6587dc094e2aa8b7367ed2e658c95d2", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1ddbd25eaea325924e7b87bb3a6b74d0989d61c00f016342243f3703ef56f39a852936b4132ddcb8b7026a1e8ad68a24b343380f9477b0087f65eebdd30498bb"} build_url:https://queue.taskcluster.net/v1/task/SnPiQaAJQmqSN7jo34Jbdw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011553 build_url: 'https://queue.taskcluster.net/v1/task/SnPiQaAJQmqSN7jo34Jbdw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/30344cc478ddd504dd900e1e79168da0c8a02a27ed6bdf4cad22cbb0beff50ac875cd2d19cbdc2f55e1450b0e396af57466268bb881283cd7334f9a7d1f71729", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/50dc48b8e912d179c5f88fac19c9cd835a29e86d8b088756d7299668d72f979ba32726044ac134fe39d2edef472087e047a6194c36fe555d415e3d3d25caf926", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0e000366b93bc8273d134000452e1bfdc643927f2cdb1a58ebd4a271871810533b22857cb8a230c941fabc41d1a02ea5d6587dc094e2aa8b7367ed2e658c95d2", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1ddbd25eaea325924e7b87bb3a6b74d0989d61c00f016342243f3703ef56f39a852936b4132ddcb8b7026a1e8ad68a24b343380f9477b0087f65eebdd30498bb"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-18 11:45:14.948151) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 11:45:14.948652) ========= 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=dbb0bb31bf4a4c7db9ba1648000001b6-1505753956.465478-1105325866 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004549 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 11:45:15.032806) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-18 11:45:15.033271) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-18 11:45:15.033612) ========= ========= Total master_lag: 0.25 =========