builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-067 starttime: 1505068522.9 results: success (0) revision: fd87bb184e299fec695f69bd2977276c25719b98 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-10 11:35:22.898370) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-10 11:35:22.898839) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-10 11:35:22.899124) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-10 11:35:22.917592) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-10 11:35:22.917984) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1505067859.53232-898075472 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-10 11:35:22-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 87.1M=0s 2017-09-10 11:35:23 (87.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.138695 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-10 11:35:23.073729) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-10 11:35:23.074071) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1505067859.53232-898075472 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021289 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-10 11:35:23.123599) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-10 11:35:23.123968) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev fd87bb184e299fec695f69bd2977276c25719b98 --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 fd87bb184e299fec695f69bd2977276c25719b98 --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=e0e61f6f900f4dc42e3e8956000001ad-1505067859.53232-898075472 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-10 11:35:23,184 truncating revision to first 12 chars 2017-09-10 11:35:23,184 Setting DEBUG logging. 2017-09-10 11:35:23,184 attempt 1/10 2017-09-10 11:35:23,184 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/fd87bb184e29?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-10 11:35:23,664 unpacking tar archive at: mozilla-central-fd87bb184e29/testing/mozharness/ program finished with exit code 0 elapsedTime=0.813382 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-10 11:35:23.966721) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-10 11:35:23.967006) ========= script_repo_revision: fd87bb184e299fec695f69bd2977276c25719b98 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-10 11:35:23.967685) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-10 11:35:23.967955) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-10 11:35:24.018886) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2017-09-10 11:35:24.019163) ========= /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=e0e61f6f900f4dc42e3e8956000001ad-1505067859.53232-898075472 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:35:24 INFO - MultiFileLogger online at 20170910 11:35:24 in /builds/slave/test 11:35:24 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:35:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:35:24 INFO - {'append_to_log': False, 11:35:24 INFO - 'base_work_dir': '/builds/slave/test', 11:35:24 INFO - 'blob_upload_branch': 'Firefox', 11:35:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:35:24 INFO - 'branch': 'Firefox', 11:35:24 INFO - 'buildbot_json_path': 'buildprops.json', 11:35:24 INFO - 'code_coverage': False, 11:35:24 INFO - 'config_files': ('talos/linux_config.py',), 11:35:24 INFO - 'default_actions': ('clobber', 11:35:24 INFO - 'read-buildbot-config', 11:35:24 INFO - 'download-and-extract', 11:35:24 INFO - 'populate-webroot', 11:35:24 INFO - 'create-virtualenv', 11:35:24 INFO - 'install', 11:35:24 INFO - 'setup-mitmproxy', 11:35:24 INFO - 'run-tests'), 11:35:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:35:24 INFO - 'disable_ccov_upload': False, 11:35:24 INFO - 'disable_stylo': False, 11:35:24 INFO - 'download_minidump_stackwalk': True, 11:35:24 INFO - 'download_symbols': 'ondemand', 11:35:24 INFO - 'enable_stylo': False, 11:35:24 INFO - 'enable_webrender': False, 11:35:24 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 11:35:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:35:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:35:24 INFO - 'gecko_profile': False, 11:35:24 INFO - 'gecko_profile_interval': 0, 11:35:24 INFO - 'installer_path': 'installer.exe', 11:35:24 INFO - 'log_level': 'info', 11:35:24 INFO - 'log_name': 'talos', 11:35:24 INFO - 'log_to_console': True, 11:35:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:35:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:35:24 INFO - 'opt_config_files': (), 11:35:24 INFO - 'pip_index': False, 11:35:24 INFO - 'suite': 'dromaeojs-e10s', 11:35:24 INFO - 'system_bits': '32', 11:35:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:35:24 INFO - 'title': 'talos-linux64-ix-067', 11:35:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:35:24 INFO - 'use_talos_json': True, 11:35:24 INFO - 'verify': 'False', 11:35:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:35:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:35:24 INFO - 'work_dir': 'build'} 11:35:24 INFO - [mozharness: 2017-09-10 18:35:24.215226Z] Running clobber step. 11:35:24 INFO - Running pre-action listener: _resource_record_pre_action 11:35:24 INFO - Running main action method: clobber 11:35:24 INFO - rmtree: /builds/slave/test/build 11:35:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:35:25 INFO - Running post-action listener: _resource_record_post_action 11:35:25 INFO - [mozharness: 2017-09-10 18:35:25.750588Z] Finished clobber step (success) 11:35:25 INFO - [mozharness: 2017-09-10 18:35:25.750685Z] Running read-buildbot-config step. 11:35:25 INFO - Running pre-action listener: _resource_record_pre_action 11:35:25 INFO - Running main action method: read_buildbot_config 11:35:25 INFO - Using buildbot properties: 11:35:25 INFO - { 11:35:25 INFO - "project": "", 11:35:25 INFO - "product": "firefox", 11:35:25 INFO - "who": "ffxbld@noreply.mozilla.org", 11:35:25 INFO - "installer_path": "public/build/target.tar.bz2", 11:35:25 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 11:35:25 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:35:25 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 11:35:25 INFO - "stage_platform": "linux64-pgo", 11:35:25 INFO - "basedir": "/builds/slave/test", 11:35:25 INFO - "buildnumber": 174, 11:35:25 INFO - "platform": "ubuntu64_hw", 11:35:25 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:35:25 INFO - "slavebuilddir": "test", 11:35:25 INFO - "taskId": "Vy2d7Y86TeKRHkzqiPd7Ow", 11:35:25 INFO - "branch": "mozilla-central", 11:35:25 INFO - "script_repo_revision": "production", 11:35:25 INFO - "revision": "fd87bb184e299fec695f69bd2977276c25719b98", 11:35:25 INFO - "slavename": "talos-linux64-ix-067", 11:35:25 INFO - "repo_path": "mozilla-central" 11:35:25 INFO - } 11:35:25 INFO - Finding installer, test and symbols from parent task. 11:35:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Vy2d7Y86TeKRHkzqiPd7Ow'}, attempt #1 11:35:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Vy2d7Y86TeKRHkzqiPd7Ow'}, attempt #1 11:35:26 INFO - Task dependencies: LDhY0lhSTCW5nAVURJ1tfA 11:35:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LDhY0lhSTCW5nAVURJ1tfA'}, attempt #1 11:35:27 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/LDhY0lhSTCW5nAVURJ1tfA/artifacts/public/build/target.tar.bz2 11:35:27 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/LDhY0lhSTCW5nAVURJ1tfA/artifacts/public/build/target.test_packages.json 11:35:27 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/LDhY0lhSTCW5nAVURJ1tfA/artifacts/public/build/target.crashreporter-symbols.zip 11:35:27 INFO - Running post-action listener: _resource_record_post_action 11:35:27 INFO - [mozharness: 2017-09-10 18:35:27.292304Z] Finished read-buildbot-config step (success) 11:35:27 INFO - [mozharness: 2017-09-10 18:35:27.292521Z] Running download-and-extract step. 11:35:27 INFO - Running pre-action listener: _resource_record_pre_action 11:35:27 INFO - Running main action method: download_and_extract 11:35:27 INFO - mkdir: /builds/slave/test/build/tests 11:35: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:35:27 INFO - trying https://queue.taskcluster.net/v1/task/LDhY0lhSTCW5nAVURJ1tfA/artifacts/public/build/target.test_packages.json 11:35:27 INFO - Downloading https://queue.taskcluster.net/v1/task/LDhY0lhSTCW5nAVURJ1tfA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:35:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LDhY0lhSTCW5nAVURJ1tfA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:35:28 INFO - Downloaded 989 bytes. 11:35:28 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:35:28 INFO - Using the following test package requirements: 11:35:28 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:35:28 INFO - u'common': [u'target.common.tests.zip'], 11:35:28 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:35:28 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:35:28 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:35:28 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:35:28 INFO - u'mozbase': [u'target.common.tests.zip'], 11:35:28 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:35:28 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:35:28 INFO - u'web-platform': [u'target.common.tests.zip', 11:35:28 INFO - u'target.web-platform.tests.tar.gz'], 11:35:28 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:35:28 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 11:35:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LDhY0lhSTCW5nAVURJ1tfA/artifacts/public/build/target.common.tests.zip 11:35:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LDhY0lhSTCW5nAVURJ1tfA/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:35:28 INFO - Fetch https://queue.taskcluster.net/v1/task/LDhY0lhSTCW5nAVURJ1tfA/artifacts/public/build/target.common.tests.zip into memory 11:35:29 INFO - Content-Length response header: 55697603 11:35:29 INFO - Bytes received: 55697603 11:35:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LDhY0lhSTCW5nAVURJ1tfA/artifacts/public/build/target.talos.tests.zip 11:35:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LDhY0lhSTCW5nAVURJ1tfA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:35:40 INFO - Fetch https://queue.taskcluster.net/v1/task/LDhY0lhSTCW5nAVURJ1tfA/artifacts/public/build/target.talos.tests.zip into memory 11:35:40 INFO - Content-Length response header: 14497963 11:35:40 INFO - Bytes received: 14497963 11:35:41 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:35:41 INFO - trying https://queue.taskcluster.net/v1/task/LDhY0lhSTCW5nAVURJ1tfA/artifacts/public/build/target.tar.bz2 11:35:41 INFO - Downloading https://queue.taskcluster.net/v1/task/LDhY0lhSTCW5nAVURJ1tfA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:35:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LDhY0lhSTCW5nAVURJ1tfA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:35:44 INFO - Downloaded 63678461 bytes. 11:35:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LDhY0lhSTCW5nAVURJ1tfA/artifacts/public/build/target.tar.bz2 11:35:44 INFO - mkdir: /builds/slave/test/properties 11:35:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:35:44 INFO - Writing to file /builds/slave/test/properties/build_url 11:35:44 INFO - Contents: 11:35:44 INFO - build_url:https://queue.taskcluster.net/v1/task/LDhY0lhSTCW5nAVURJ1tfA/artifacts/public/build/target.tar.bz2 11:35:44 INFO - Running post-action listener: _resource_record_post_action 11:35:44 INFO - Running post-action listener: find_tests_for_verification 11:35:44 INFO - Running post-action listener: set_extra_try_arguments 11:35:44 INFO - [mozharness: 2017-09-10 18:35:44.112397Z] Finished download-and-extract step (success) 11:35:44 INFO - [mozharness: 2017-09-10 18:35:44.112625Z] Running populate-webroot step. 11:35:44 INFO - Running pre-action listener: _resource_record_pre_action 11:35:44 INFO - Running main action method: populate_webroot 11:35:44 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:35:44 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:35:44 INFO - 'tests': ['tresize', 11:35:44 INFO - 'tcanvasmark']}, 11:35:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:35:44 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:35:44 INFO - 'tests': ['dromaeo_css', 11:35:44 INFO - 'kraken']}, 11:35:44 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:35:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:35:44 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:35:44 INFO - 'talos_options': ['--disable-stylo'], 11:35:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:35:44 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:35:44 INFO - 'tests': ['damp', 'tps']}, 11:35:44 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:35:44 INFO - 'talos_options': ['--disable-stylo'], 11:35:44 INFO - 'tests': ['damp', 'tps']}, 11:35:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:35:44 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:35:44 INFO - 'tests': ['dromaeo_dom']}, 11:35:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:35:44 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:35:44 INFO - 'tests': ['basic_compositor_video', 11:35:44 INFO - 'glvideo']}, 11:35:44 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:35:44 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:35:44 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:35:44 INFO - 'talos_options': ['--disable-stylo'], 11:35:44 INFO - 'tests': ['ts_paint_webext', 11:35:44 INFO - 'tp5o_webext']}, 11:35:44 INFO - 'other-e10s': {'tests': ['a11yr', 11:35:44 INFO - 'ts_paint', 11:35:44 INFO - 'tpaint', 11:35:44 INFO - 'sessionrestore', 11:35:44 INFO - 'sessionrestore_many_windows', 11:35:44 INFO - 'sessionrestore_no_auto_restore', 11:35:44 INFO - 'tabpaint']}, 11:35:44 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:35:44 INFO - 'tests': ['a11yr', 11:35:44 INFO - 'ts_paint', 11:35:44 INFO - 'tpaint', 11:35:44 INFO - 'sessionrestore', 11:35:44 INFO - 'sessionrestore_many_windows', 11:35:44 INFO - 'sessionrestore_no_auto_restore', 11:35:44 INFO - 'tabpaint']}, 11:35:44 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 11:35:44 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 11:35:44 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:35:44 INFO - 'tests': ['bloom_basic_singleton']}, 11:35:44 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:35:44 INFO - 'tests': ['bloom_basic']}, 11:35:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:35:44 INFO - 'tsvgr_opacity', 11:35:44 INFO - 'tart', 11:35:44 INFO - 'tscrollx', 11:35:44 INFO - 'tsvg_static']}, 11:35:44 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:35:44 INFO - 'tests': ['tsvgx', 11:35:44 INFO - 'tsvgr_opacity', 11:35:44 INFO - 'tart', 11:35:44 INFO - 'tscrollx', 11:35:44 INFO - 'tsvg_static']}, 11:35:44 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:35:44 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:35:44 INFO - 'talos_options': ['--disable-stylo'], 11:35:44 INFO - 'tests': ['tp5o']}, 11:35:44 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:35:44 INFO - 'talos_options': ['--mitmproxy', 11:35:44 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:35:44 INFO - '--firstNonBlankPaint'], 11:35:44 INFO - 'tests': ['tp6_google', 11:35:44 INFO - 'tp6_youtube', 11:35:44 INFO - 'tp6_amazon', 11:35:44 INFO - 'tp6_facebook']}, 11:35:44 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:35:44 INFO - 'talos_options': ['--disable-stylo', 11:35:44 INFO - '--mitmproxy', 11:35:44 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:35:44 INFO - '--firstNonBlankPaint'], 11:35:44 INFO - 'tests': ['tp6_google', 11:35:44 INFO - 'tp6_youtube', 11:35:44 INFO - 'tp6_amazon', 11:35:44 INFO - 'tp6_facebook']}, 11:35:44 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:35:44 INFO - 'talos_options': ['--stylo-threads=1', 11:35:44 INFO - '--mitmproxy', 11:35:44 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:35:44 INFO - '--firstNonBlankPaint'], 11:35:44 INFO - 'tests': ['tp6_google', 11:35:44 INFO - 'tp6_youtube', 11:35:44 INFO - 'tp6_amazon', 11:35:44 INFO - 'tp6_facebook']}, 11:35:44 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:35:44 INFO - 'talos_options': ['--xperf_path', 11:35:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:35:44 INFO - 'tests': ['tp5n']}, 11:35:44 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:35:44 INFO - 'talos_options': ['--disable-stylo', 11:35:44 INFO - '--xperf_path', 11:35:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:35:44 INFO - 'tests': ['tp5n']}}} 11:35:44 INFO - Running post-action listener: _resource_record_post_action 11:35:44 INFO - [mozharness: 2017-09-10 18:35:44.135939Z] Finished populate-webroot step (success) 11:35:44 INFO - [mozharness: 2017-09-10 18:35:44.136028Z] Running create-virtualenv step. 11:35:44 INFO - Running pre-action listener: _resource_record_pre_action 11:35:44 INFO - Running main action method: create_virtualenv 11:35:44 INFO - Creating virtualenv /builds/slave/test/build/venv 11:35:44 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:35:44 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 11:35:44 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:35:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:35:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:35:44 INFO - Installing distribute.............................................................................................................................................................................................done. 11:35:45 INFO - Installing pip...............done. 11:35:45 INFO - Return code: 0 11:35:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:35:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:35:45 INFO - Reading from file tmpfile_stdout 11:35:45 INFO - Output received: 11:35:45 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:35:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:35:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:35:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:35:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:35:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:35:45 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 0xd4f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf18a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf090>, '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 0x10bfd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b9f90>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1505067859.53232-898075472', '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:35:45 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:35:45 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:35:45 INFO - Using env: {'DISPLAY': ':0', 11:35:45 INFO - 'HOME': '/home/cltbld', 11:35:45 INFO - 'LANG': 'en_US.UTF-8', 11:35:45 INFO - 'LANGUAGE': 'en_US:en', 11:35:45 INFO - 'LOGNAME': 'cltbld', 11:35:45 INFO - 'MAIL': '/var/mail/cltbld', 11:35:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:35:45 INFO - 'MOZ_NO_REMOTE': '1', 11:35:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:35:45 INFO - 'NO_EM_RESTART': '1', 11:35:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:35:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:35:45 INFO - 'PWD': '/builds/slave/test', 11:35:45 INFO - 'SHELL': '/bin/bash', 11:35:45 INFO - 'SHLVL': '1', 11:35:45 INFO - 'TERM': 'linux', 11:35:45 INFO - 'TMOUT': '86400', 11:35:45 INFO - 'USER': 'cltbld', 11:35:45 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1505067859.53232-898075472', 11:35:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:35:45 INFO - '_': '/tools/buildbot/bin/python'} 11:35:46 INFO - Ignoring indexes: http://pypi.python.org/simple/ 11:35:46 INFO - Downloading/unpacking pip>=1.5 11:35:46 INFO - Running setup.py egg_info for package pip 11:35:46 INFO - warning: no files found matching 'pip/cacert.pem' 11:35:46 INFO - warning: no files found matching '*.html' under directory 'docs' 11:35:46 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:35:46 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:35:46 INFO - Installing collected packages: pip 11:35:46 INFO - Found existing installation: pip 1.1 11:35:46 INFO - Uninstalling pip: 11:35:46 INFO - Successfully uninstalled pip 11:35:46 INFO - Running setup.py install for pip 11:35:46 INFO - warning: no files found matching 'pip/cacert.pem' 11:35:46 INFO - warning: no files found matching '*.html' under directory 'docs' 11:35:46 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:35:46 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:35:46 INFO - Installing pip script to /builds/slave/test/build/venv/bin 11:35:46 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 11:35:46 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 11:35:46 INFO - Successfully installed pip 11:35:46 INFO - Cleaning up... 11:35:46 INFO - Return code: 0 11:35:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:35:46 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:35:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:35:46 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:35:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:35:46 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 0xd4f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf18a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf090>, '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 0x10bfd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b9f90>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1505067859.53232-898075472', '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:35:46 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:35:46 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:35:46 INFO - Using env: {'DISPLAY': ':0', 11:35:46 INFO - 'HOME': '/home/cltbld', 11:35:46 INFO - 'LANG': 'en_US.UTF-8', 11:35:46 INFO - 'LANGUAGE': 'en_US:en', 11:35:46 INFO - 'LOGNAME': 'cltbld', 11:35:46 INFO - 'MAIL': '/var/mail/cltbld', 11:35:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:35:46 INFO - 'MOZ_NO_REMOTE': '1', 11:35:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:35:46 INFO - 'NO_EM_RESTART': '1', 11:35:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:35:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:35:46 INFO - 'PWD': '/builds/slave/test', 11:35:46 INFO - 'SHELL': '/bin/bash', 11:35:46 INFO - 'SHLVL': '1', 11:35:46 INFO - 'TERM': 'linux', 11:35:46 INFO - 'TMOUT': '86400', 11:35:46 INFO - 'USER': 'cltbld', 11:35:46 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1505067859.53232-898075472', 11:35:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:35:46 INFO - '_': '/tools/buildbot/bin/python'} 11:35:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:35:46 INFO - Downloading/unpacking psutil>=3.1.1 11:35:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:35:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:35:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:35:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:35:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:35:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:35:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:35:47 INFO - Installing collected packages: psutil 11:35:47 INFO - Running setup.py install for psutil 11:35:47 INFO - building 'psutil._psutil_linux' extension 11:35:47 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:35:47 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:35:47 INFO - building 'psutil._psutil_posix' extension 11:35:47 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:35:48 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:35:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:35:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:35:48 INFO - Successfully installed psutil 11:35:48 INFO - Cleaning up... 11:35:48 INFO - Return code: 0 11:35:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:35:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:35:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:35:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:35:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:35:48 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 0xd4f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf18a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf090>, '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 0x10bfd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b9f90>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1505067859.53232-898075472', '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:35:48 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:35:48 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:35:48 INFO - Using env: {'DISPLAY': ':0', 11:35:48 INFO - 'HOME': '/home/cltbld', 11:35:48 INFO - 'LANG': 'en_US.UTF-8', 11:35:48 INFO - 'LANGUAGE': 'en_US:en', 11:35:48 INFO - 'LOGNAME': 'cltbld', 11:35:48 INFO - 'MAIL': '/var/mail/cltbld', 11:35:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:35:48 INFO - 'MOZ_NO_REMOTE': '1', 11:35:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:35:48 INFO - 'NO_EM_RESTART': '1', 11:35:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:35:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:35:48 INFO - 'PWD': '/builds/slave/test', 11:35:48 INFO - 'SHELL': '/bin/bash', 11:35:48 INFO - 'SHLVL': '1', 11:35:48 INFO - 'TERM': 'linux', 11:35:48 INFO - 'TMOUT': '86400', 11:35:48 INFO - 'USER': 'cltbld', 11:35:48 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1505067859.53232-898075472', 11:35:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:35:48 INFO - '_': '/tools/buildbot/bin/python'} 11:35:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:35:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:35:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:35:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:35:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:35:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:35:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:35:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:35:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:35:49 INFO - Installing collected packages: mozsystemmonitor 11:35:49 INFO - Running setup.py install for mozsystemmonitor 11:35:49 INFO - Successfully installed mozsystemmonitor 11:35:49 INFO - Cleaning up... 11:35:50 INFO - Return code: 0 11:35:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:35: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:35:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:35: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:35:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:35:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf18a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf090>, '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 0x10bfd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b9f90>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1505067859.53232-898075472', '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:35:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:35:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:35:50 INFO - Using env: {'DISPLAY': ':0', 11:35:50 INFO - 'HOME': '/home/cltbld', 11:35:50 INFO - 'LANG': 'en_US.UTF-8', 11:35:50 INFO - 'LANGUAGE': 'en_US:en', 11:35:50 INFO - 'LOGNAME': 'cltbld', 11:35:50 INFO - 'MAIL': '/var/mail/cltbld', 11:35:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:35:50 INFO - 'MOZ_NO_REMOTE': '1', 11:35:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:35:50 INFO - 'NO_EM_RESTART': '1', 11:35:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:35:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:35:50 INFO - 'PWD': '/builds/slave/test', 11:35:50 INFO - 'SHELL': '/bin/bash', 11:35:50 INFO - 'SHLVL': '1', 11:35:50 INFO - 'TERM': 'linux', 11:35:50 INFO - 'TMOUT': '86400', 11:35:50 INFO - 'USER': 'cltbld', 11:35:50 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1505067859.53232-898075472', 11:35:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:35:50 INFO - '_': '/tools/buildbot/bin/python'} 11:35:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:35:50 INFO - Downloading/unpacking jsonschema==2.5.1 11:35:50 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:35:50 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:35:50 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:35:50 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:35:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:35:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:35: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:35: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:35: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:35: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:35:51 INFO - Downloading functools32-3.2.3-2.tar.gz 11:35:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:35:52 INFO - warning: no files found matching '*.txt' 11:35:52 INFO - no previously-included directories found matching 'build' 11:35:52 INFO - no previously-included directories found matching 'dist' 11:35:52 INFO - no previously-included directories found matching '.git*' 11:35:52 INFO - Installing collected packages: jsonschema, functools32 11:35:52 INFO - Running setup.py install for functools32 11:35:52 INFO - warning: no files found matching '*.txt' 11:35:52 INFO - no previously-included directories found matching 'build' 11:35:52 INFO - no previously-included directories found matching 'dist' 11:35:52 INFO - no previously-included directories found matching '.git*' 11:35:52 INFO - Successfully installed jsonschema functools32 11:35:52 INFO - Cleaning up... 11:35:52 INFO - Return code: 0 11:35:52 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:35: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:35:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:35: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:35:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:35: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', '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 0xd4f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf18a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf090>, '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 0x10bfd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b9f90>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1505067859.53232-898075472', '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:35: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:35: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 functools32==3.2.3-2 11:35:52 INFO - Using env: {'DISPLAY': ':0', 11:35:52 INFO - 'HOME': '/home/cltbld', 11:35:52 INFO - 'LANG': 'en_US.UTF-8', 11:35:52 INFO - 'LANGUAGE': 'en_US:en', 11:35:52 INFO - 'LOGNAME': 'cltbld', 11:35:52 INFO - 'MAIL': '/var/mail/cltbld', 11:35:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:35:52 INFO - 'MOZ_NO_REMOTE': '1', 11:35:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:35:52 INFO - 'NO_EM_RESTART': '1', 11:35:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:35:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:35:52 INFO - 'PWD': '/builds/slave/test', 11:35:52 INFO - 'SHELL': '/bin/bash', 11:35:52 INFO - 'SHLVL': '1', 11:35:52 INFO - 'TERM': 'linux', 11:35:52 INFO - 'TMOUT': '86400', 11:35:52 INFO - 'USER': 'cltbld', 11:35:52 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1505067859.53232-898075472', 11:35:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:35:52 INFO - '_': '/tools/buildbot/bin/python'} 11:35:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:35:52 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:35:52 INFO - Cleaning up... 11:35:52 INFO - Return code: 0 11:35:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:35: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:35:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:35: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:35:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:35: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', '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 0xd4f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf18a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf090>, '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 0x10bfd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b9f90>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1505067859.53232-898075472', '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:35: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:35: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 blobuploader==1.2.4 11:35:52 INFO - Using env: {'DISPLAY': ':0', 11:35:52 INFO - 'HOME': '/home/cltbld', 11:35:52 INFO - 'LANG': 'en_US.UTF-8', 11:35:52 INFO - 'LANGUAGE': 'en_US:en', 11:35:52 INFO - 'LOGNAME': 'cltbld', 11:35:52 INFO - 'MAIL': '/var/mail/cltbld', 11:35:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:35:52 INFO - 'MOZ_NO_REMOTE': '1', 11:35:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:35:52 INFO - 'NO_EM_RESTART': '1', 11:35:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:35:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:35:52 INFO - 'PWD': '/builds/slave/test', 11:35:52 INFO - 'SHELL': '/bin/bash', 11:35:52 INFO - 'SHLVL': '1', 11:35:52 INFO - 'TERM': 'linux', 11:35:52 INFO - 'TMOUT': '86400', 11:35:52 INFO - 'USER': 'cltbld', 11:35:52 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1505067859.53232-898075472', 11:35:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:35:52 INFO - '_': '/tools/buildbot/bin/python'} 11:35:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:35:52 INFO - Downloading/unpacking blobuploader==1.2.4 11:35:52 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:35:52 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:35:52 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:35:52 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:35:53 INFO - Downloading blobuploader-1.2.4.tar.gz 11:35:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:35:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:35: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:35: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:35: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:35: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:35:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:35:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:35:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:35:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:35:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:35:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:35:54 INFO - Downloading docopt-0.6.1.tar.gz 11:35:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:35:54 INFO - Installing collected packages: blobuploader, requests, docopt 11:35:54 INFO - Running setup.py install for blobuploader 11:35:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:35:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:35:54 INFO - Running setup.py install for requests 11:35:54 INFO - Running setup.py install for docopt 11:35:54 INFO - Successfully installed blobuploader requests docopt 11:35:54 INFO - Cleaning up... 11:35:54 INFO - Return code: 0 11:35:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:35:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:35:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:35:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:35:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:35:54 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 0xd4f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf18a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf090>, '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 0x10bfd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b9f90>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1505067859.53232-898075472', '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:35:54 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:35:54 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:35:54 INFO - Using env: {'DISPLAY': ':0', 11:35:54 INFO - 'HOME': '/home/cltbld', 11:35:54 INFO - 'LANG': 'en_US.UTF-8', 11:35:54 INFO - 'LANGUAGE': 'en_US:en', 11:35:54 INFO - 'LOGNAME': 'cltbld', 11:35:54 INFO - 'MAIL': '/var/mail/cltbld', 11:35:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:35:54 INFO - 'MOZ_NO_REMOTE': '1', 11:35:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:35:54 INFO - 'NO_EM_RESTART': '1', 11:35:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:35:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:35:54 INFO - 'PWD': '/builds/slave/test', 11:35:54 INFO - 'SHELL': '/bin/bash', 11:35:54 INFO - 'SHLVL': '1', 11:35:54 INFO - 'TERM': 'linux', 11:35:55 INFO - 'TMOUT': '86400', 11:35:55 INFO - 'USER': 'cltbld', 11:35:55 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1505067859.53232-898075472', 11:35:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:35:55 INFO - '_': '/tools/buildbot/bin/python'} 11:35:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:35:55 INFO - Running setup.py (path:/tmp/pip-cvdfFR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:35:55 INFO - Running setup.py (path:/tmp/pip-qymSU0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:35:55 INFO - Running setup.py (path:/tmp/pip-uChX2_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:35:55 INFO - Running setup.py (path:/tmp/pip-s2sRXf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:35:55 INFO - Running setup.py (path:/tmp/pip-lTnhvt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:35:55 INFO - Running setup.py (path:/tmp/pip-jYwIFv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:35:55 INFO - Running setup.py (path:/tmp/pip-muTFGp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:35:55 INFO - Running setup.py (path:/tmp/pip-48fMGj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:35:55 INFO - Running setup.py (path:/tmp/pip-1G0K9k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:35:55 INFO - Running setup.py (path:/tmp/pip-PpMMPr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:35:55 INFO - Running setup.py (path:/tmp/pip-Stz00C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:35:55 INFO - Running setup.py (path:/tmp/pip-iYNJSF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:35:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:35:56 INFO - Running setup.py (path:/tmp/pip-uKOTlq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:35:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:35:56 INFO - Running setup.py (path:/tmp/pip-UUPZ5g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:35:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:35:56 INFO - Running setup.py (path:/tmp/pip-6NJY8T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:35:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:35:56 INFO - Running setup.py (path:/tmp/pip-m9FEAV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:35:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:35:56 INFO - Running setup.py (path:/tmp/pip-ta_uSR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:35:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:35:56 INFO - Running setup.py install for manifestparser 11:35:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:35:56 INFO - Running setup.py install for mozcrash 11:35:56 INFO - Running setup.py install for mozdebug 11:35:56 INFO - Running setup.py install for mozdevice 11:35:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:35:56 INFO - Running setup.py install for mozfile 11:35:56 INFO - Running setup.py install for mozhttpd 11:35:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:35:56 INFO - Running setup.py install for mozinfo 11:35:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:35:57 INFO - Running setup.py install for mozInstall 11:35:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:35:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:35:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:35:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:35:57 INFO - Running setup.py install for mozleak 11:35:57 INFO - Running setup.py install for mozlog 11:35:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:35:57 INFO - Running setup.py install for moznetwork 11:35:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:35:57 INFO - Running setup.py install for mozprocess 11:35:57 INFO - Running setup.py install for mozprofile 11:35:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:35:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:35:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:35:57 INFO - Running setup.py install for mozrunner 11:35:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:35:57 INFO - Running setup.py install for mozscreenshot 11:35:57 INFO - Running setup.py install for moztest 11:35:58 INFO - Running setup.py install for mozversion 11:35:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:35:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:35:58 INFO - Cleaning up... 11:35:58 INFO - Return code: 0 11:35:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:35: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:35:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:35: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:35:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:35:58 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 0xd4f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf18a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf090>, '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 0x10bfd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b9f90>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1505067859.53232-898075472', '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:35:58 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:35:58 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:35:58 INFO - Using env: {'DISPLAY': ':0', 11:35:58 INFO - 'HOME': '/home/cltbld', 11:35:58 INFO - 'LANG': 'en_US.UTF-8', 11:35:58 INFO - 'LANGUAGE': 'en_US:en', 11:35:58 INFO - 'LOGNAME': 'cltbld', 11:35:58 INFO - 'MAIL': '/var/mail/cltbld', 11:35:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:35:58 INFO - 'MOZ_NO_REMOTE': '1', 11:35:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:35:58 INFO - 'NO_EM_RESTART': '1', 11:35:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:35:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:35:58 INFO - 'PWD': '/builds/slave/test', 11:35:58 INFO - 'SHELL': '/bin/bash', 11:35:58 INFO - 'SHLVL': '1', 11:35:58 INFO - 'TERM': 'linux', 11:35:58 INFO - 'TMOUT': '86400', 11:35:58 INFO - 'USER': 'cltbld', 11:35:58 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1505067859.53232-898075472', 11:35:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:35:58 INFO - '_': '/tools/buildbot/bin/python'} 11:35:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:35:58 INFO - Running setup.py (path:/tmp/pip-wnxwJE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:35:58 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:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:35:58 INFO - Running setup.py (path:/tmp/pip-PjsVsT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:35:58 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:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:35:58 INFO - Running setup.py (path:/tmp/pip-a_KrTJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:35:58 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:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:35:58 INFO - Running setup.py (path:/tmp/pip-H3U6CS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:35:58 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:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:35:58 INFO - Running setup.py (path:/tmp/pip-9LjOHa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:35:58 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:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:35:58 INFO - Running setup.py (path:/tmp/pip-wtqGWY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:35:58 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:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:35:58 INFO - Running setup.py (path:/tmp/pip-qxYxZL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:35:58 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:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:35:58 INFO - Running setup.py (path:/tmp/pip-axpWhi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:35:58 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:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:35:58 INFO - Running setup.py (path:/tmp/pip-fVYCeF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:35:58 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:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:35:59 INFO - Running setup.py (path:/tmp/pip-Wrp7Bf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:35:59 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:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:35:59 INFO - Running setup.py (path:/tmp/pip-XiglNb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:35:59 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:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:35:59 INFO - Running setup.py (path:/tmp/pip-RkE0Nb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:35:59 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:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:35:59 INFO - Running setup.py (path:/tmp/pip-1sFmQS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:35:59 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:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:35:59 INFO - Running setup.py (path:/tmp/pip-T58fTm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:35:59 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:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:35:59 INFO - Running setup.py (path:/tmp/pip-32Io_i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:35:59 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:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:35:59 INFO - Running setup.py (path:/tmp/pip-FGS8yE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:35:59 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:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:35:59 INFO - Running setup.py (path:/tmp/pip-tZGW4y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:35:59 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:35:59 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:35:59 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:35:59 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:35:59 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:35:59 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:35:59 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:35:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:35: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:35: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:35: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:35: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:36:00 INFO - Downloading blessings-1.6.tar.gz 11:36:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:36:00 INFO - Installing collected packages: blessings 11:36:00 INFO - Running setup.py install for blessings 11:36:00 INFO - Successfully installed blessings 11:36:00 INFO - Cleaning up... 11:36:00 INFO - Return code: 0 11:36:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:36:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:36:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:36:01 INFO - Reading from file tmpfile_stdout 11:36:01 INFO - Current package versions: 11:36:01 INFO - argparse == 1.2.1 11:36:01 INFO - blessings == 1.6 11:36:01 INFO - blobuploader == 1.2.4 11:36:01 INFO - docopt == 0.6.1 11:36:01 INFO - functools32 == 3.2.3-2 11:36:01 INFO - jsonschema == 2.5.1 11:36:01 INFO - manifestparser == 1.1 11:36:01 INFO - mozInstall == 1.13 11:36:01 INFO - mozcrash == 1.0 11:36:01 INFO - mozdebug == 0.1 11:36:01 INFO - mozdevice == 0.51 11:36:01 INFO - mozfile == 1.2 11:36:01 INFO - mozhttpd == 0.7 11:36:01 INFO - mozinfo == 0.10 11:36:01 INFO - mozleak == 0.1 11:36:01 INFO - mozlog == 3.5 11:36:01 INFO - moznetwork == 0.27 11:36:01 INFO - mozprocess == 0.25 11:36:01 INFO - mozprofile == 0.28 11:36:01 INFO - mozrunner == 6.13 11:36:01 INFO - mozscreenshot == 0.1 11:36:01 INFO - mozsystemmonitor == 0.3 11:36:01 INFO - moztest == 0.8 11:36:01 INFO - mozversion == 1.4 11:36:01 INFO - psutil == 3.1.1 11:36:01 INFO - requests == 1.2.3 11:36:01 INFO - wsgiref == 0.1.2 11:36:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:36:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:36:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:36:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:36:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:36:01 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 0xd4f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf18a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf090>, '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 0x10bfd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b9f90>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1505067859.53232-898075472', '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:36:01 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:36:01 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:36:01 INFO - Using env: {'DISPLAY': ':0', 11:36:01 INFO - 'HOME': '/home/cltbld', 11:36:01 INFO - 'LANG': 'en_US.UTF-8', 11:36:01 INFO - 'LANGUAGE': 'en_US:en', 11:36:01 INFO - 'LOGNAME': 'cltbld', 11:36:01 INFO - 'MAIL': '/var/mail/cltbld', 11:36:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:36:01 INFO - 'MOZ_NO_REMOTE': '1', 11:36:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:36:01 INFO - 'NO_EM_RESTART': '1', 11:36:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:36:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:36:01 INFO - 'PWD': '/builds/slave/test', 11:36:01 INFO - 'SHELL': '/bin/bash', 11:36:01 INFO - 'SHLVL': '1', 11:36:01 INFO - 'TERM': 'linux', 11:36:01 INFO - 'TMOUT': '86400', 11:36:01 INFO - 'USER': 'cltbld', 11:36:01 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1505067859.53232-898075472', 11:36:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:36:01 INFO - '_': '/tools/buildbot/bin/python'} 11:36:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:36:01 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:36:01 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:36:01 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:36:01 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:36:01 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:36:01 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:36:01 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:36:01 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:36:01 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:36:01 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:36:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:36:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:36:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:36:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:36:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:36:02 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:36:02 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:36:02 INFO - Installing collected packages: simplejson 11:36:02 INFO - Running setup.py install for simplejson 11:36:02 INFO - building 'simplejson._speedups' extension 11:36:02 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:36:03 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:36:03 INFO - Successfully installed simplejson 11:36:03 INFO - Cleaning up... 11:36:03 INFO - Return code: 0 11:36:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:36: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:36:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:36: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:36:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:36:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf18a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf090>, '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 0x10bfd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b9f90>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1505067859.53232-898075472', '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:36:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:36:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:36:03 INFO - Using env: {'DISPLAY': ':0', 11:36:03 INFO - 'HOME': '/home/cltbld', 11:36:03 INFO - 'LANG': 'en_US.UTF-8', 11:36:03 INFO - 'LANGUAGE': 'en_US:en', 11:36:03 INFO - 'LOGNAME': 'cltbld', 11:36:03 INFO - 'MAIL': '/var/mail/cltbld', 11:36:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:36:03 INFO - 'MOZ_NO_REMOTE': '1', 11:36:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:36:03 INFO - 'NO_EM_RESTART': '1', 11:36:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:36:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:36:03 INFO - 'PWD': '/builds/slave/test', 11:36:03 INFO - 'SHELL': '/bin/bash', 11:36:03 INFO - 'SHLVL': '1', 11:36:03 INFO - 'TERM': 'linux', 11:36:03 INFO - 'TMOUT': '86400', 11:36:03 INFO - 'USER': 'cltbld', 11:36:03 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1505067859.53232-898075472', 11:36:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:36:03 INFO - '_': '/tools/buildbot/bin/python'} 11:36:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:36:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:36:03 INFO - Cleaning up... 11:36:03 INFO - Return code: 0 11:36:03 INFO - Running post-action listener: _resource_record_post_action 11:36:03 INFO - Running post-action listener: _start_resource_monitoring 11:36:03 INFO - Starting resource monitoring. 11:36:03 INFO - [mozharness: 2017-09-10 18:36:03.846053Z] Finished create-virtualenv step (success) 11:36:03 INFO - [mozharness: 2017-09-10 18:36:03.846569Z] Running install step. 11:36:03 INFO - Running pre-action listener: _resource_record_pre_action 11:36:03 INFO - Running main action method: install 11:36:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:36:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:36:04 INFO - Reading from file tmpfile_stdout 11:36:04 INFO - Detecting whether we're running mozinstall >=1.0... 11:36:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:36:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:36:04 INFO - Reading from file tmpfile_stdout 11:36:04 INFO - Output received: 11:36:04 INFO - Usage: mozinstall [options] installer 11:36:04 INFO - Options: 11:36:04 INFO - -h, --help show this help message and exit 11:36:04 INFO - -d DEST, --destination=DEST 11:36:04 INFO - Directory to install application into. [default: 11:36:04 INFO - "/builds/slave/test"] 11:36:04 INFO - --app=APP Application being installed. [default: firefox] 11:36:04 INFO - mkdir: /builds/slave/test/build/application 11:36:04 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:36:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:36:20 INFO - Reading from file tmpfile_stdout 11:36:20 INFO - Output received: 11:36:20 INFO - /builds/slave/test/build/application/firefox/firefox 11:36:20 INFO - Running post-action listener: _resource_record_post_action 11:36:20 INFO - [mozharness: 2017-09-10 18:36:20.584556Z] Finished install step (success) 11:36:20 INFO - [mozharness: 2017-09-10 18:36:20.584810Z] Running setup-mitmproxy step. 11:36:20 INFO - Running pre-action listener: _resource_record_pre_action 11:36:20 INFO - Running main action method: setup_mitmproxy 11:36:20 INFO - Skipping: mitmproxy is not required 11:36:20 INFO - Running post-action listener: _resource_record_post_action 11:36:20 INFO - [mozharness: 2017-09-10 18:36:20.585989Z] Finished setup-mitmproxy step (success) 11:36:20 INFO - [mozharness: 2017-09-10 18:36:20.586208Z] Running run-tests step. 11:36:20 INFO - Running pre-action listener: _resource_record_pre_action 11:36:20 INFO - Running pre-action listener: _set_gcov_prefix 11:36:20 INFO - Running main action method: run_tests 11:36:20 WARNING - Try message not found. 11:36:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:36:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:36:20 INFO - Python 2.7.3 11:36:20 INFO - Return code: 0 11:36:20 INFO - grabbing minidump binary from tooltool 11:36:20 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:36:20 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 0x10bf090>, '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 0x10bfd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b9f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:36:20 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:36:20 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:36:20 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:36:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:36:20 INFO - Return code: 0 11:36:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:36:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:36:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:36:20 INFO - ENV: RUST_BACKTRACE is now full 11:36:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:36:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:36:20 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/LDhY0lhSTCW5nAVURJ1tfA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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:36:20 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/LDhY0lhSTCW5nAVURJ1tfA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-067 --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:36:20 INFO - Using env: {'DISPLAY': ':0', 11:36:20 INFO - 'HOME': '/home/cltbld', 11:36:20 INFO - 'LANG': 'en_US.UTF-8', 11:36:20 INFO - 'LANGUAGE': 'en_US:en', 11:36:20 INFO - 'LOGNAME': 'cltbld', 11:36:20 INFO - 'MAIL': '/var/mail/cltbld', 11:36:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:36:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:36:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:36:20 INFO - 'MOZ_NO_REMOTE': '1', 11:36:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:36:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:36:20 INFO - 'NO_EM_RESTART': '1', 11:36:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:36:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:36:20 INFO - 'PWD': '/builds/slave/test', 11:36:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:36:20 INFO - 'RUST_BACKTRACE': 'full', 11:36:20 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:36:20 INFO - 'SHELL': '/bin/bash', 11:36:20 INFO - 'SHLVL': '1', 11:36:20 INFO - 'TERM': 'linux', 11:36:20 INFO - 'TMOUT': '86400', 11:36:20 INFO - 'USER': 'cltbld', 11:36:20 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1505067859.53232-898075472', 11:36:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:36:20 INFO - '_': '/tools/buildbot/bin/python'} 11:36:20 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/LDhY0lhSTCW5nAVURJ1tfA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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:36:20 INFO - mozversion application_buildid: 20170910171456 11:36:20 INFO - mozversion application_changeset: fd87bb184e299fec695f69bd2977276c25719b98 11:36:20 INFO - mozversion application_display_name: Nightly 11:36:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:36:20 INFO - mozversion application_name: Firefox 11:36:20 INFO - mozversion application_remotingname: firefox 11:36:20 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:36:20 INFO - mozversion application_vendor: Mozilla 11:36:20 INFO - mozversion application_version: 57.0a1 11:36:20 INFO - mozversion platform_buildid: 20170910171456 11:36:20 INFO - mozversion platform_changeset: fd87bb184e299fec695f69bd2977276c25719b98 11:36:20 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:36:20 INFO - mozversion platform_version: 57.0a1 11:36:20 INFO - using testdate: 1505068580 11:36:20 INFO - actual date: 1505068580 11:36:20 INFO - starting webserver on 'localhost:56335' 11:36:20 INFO - SUITE-START | Running 2 tests 11:36:20 INFO - TEST-START | dromaeo_css 11:36:20 INFO - Initialising browser for dromaeo_css test... 11:36:20 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:56335/getInfo.html -profile /tmp/tmpTS9o4H/profile 11:36:20 INFO - TEST-INFO | started process 17051 (/builds/slave/test/build/application/firefox/firefox http://localhost:56335/getInfo.html) 11:36:25 INFO - TEST-INFO | 17051: exit 0 11:36:25 INFO - Browser initialized. 11:36:25 INFO - Running cycle 1/1 for dromaeo_css test... 11:36:25 INFO - Using env: {'DISPLAY': ':0', 11:36:25 INFO - 'HOME': '/home/cltbld', 11:36:25 INFO - 'JSGC_DISABLE_POISONING': '1', 11:36:25 INFO - 'LANG': 'en_US.UTF-8', 11:36:25 INFO - 'LANGUAGE': 'en_US:en', 11:36:25 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:36:25 INFO - 'LOGNAME': 'cltbld', 11:36:25 INFO - 'MAIL': '/var/mail/cltbld', 11:36:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:36:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:36:25 INFO - 'MOZ_CRASHREPORTER': '1', 11:36:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:36:25 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:36:25 INFO - 'MOZ_NO_REMOTE': '1', 11:36:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:36:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:36:25 INFO - 'NO_EM_RESTART': '1', 11:36:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:36:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:36:25 INFO - 'PWD': '/builds/slave/test', 11:36:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:36:25 INFO - 'RUST_BACKTRACE': 'full', 11:36:25 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:36:25 INFO - 'SHELL': '/bin/bash', 11:36:25 INFO - 'SHLVL': '1', 11:36:25 INFO - 'TERM': 'linux', 11:36:25 INFO - 'TMOUT': '86400', 11:36:25 INFO - 'USER': 'cltbld', 11:36:25 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1505067859.53232-898075472', 11:36:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:36:25 INFO - '_': '/tools/buildbot/bin/python'} 11:36:25 INFO - TEST-INFO | started process 17249 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTS9o4H/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:36:26 INFO - PID 17249 | 11:36:26 INFO - PID 17249 | (/builds/slave/test/build/application/firefox/firefox:17300): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:36:26 INFO - PID 17249 | 11:36:36 INFO - PID 17249 | RSS: Main: 165814272 11:36:36 INFO - PID 17249 | 11:39:33 INFO - PID 17249 | Cycle 1(1): loaded http://localhost:56335/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56335/tests/dromaeo/cssquery-ext.html) 11:39:34 INFO - PID 17249 | RSS: Main: 168235008 11:39:34 INFO - PID 17249 | 11:42:36 INFO - PID 17249 | Cycle 1(1): loaded http://localhost:56335/tests/dromaeo/cssquery-ext.html (next: http://localhost:56335/tests/dromaeo/cssquery-jquery.html) 11:42:37 INFO - PID 17249 | RSS: Main: 163184640 11:42:37 INFO - PID 17249 | 11:45:38 INFO - PID 17249 | Cycle 1(1): loaded http://localhost:56335/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56335/tests/dromaeo/cssquery-mootools.html) 11:45:39 INFO - PID 17249 | RSS: Main: 166543360 11:45:39 INFO - PID 17249 | 11:48:40 INFO - PID 17249 | Cycle 1(1): loaded http://localhost:56335/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56335/tests/dromaeo/cssquery-prototype.html) 11:48:41 INFO - PID 17249 | RSS: Main: 164892672 11:48:41 INFO - PID 17249 | 11:51:44 INFO - PID 17249 | Cycle 1(1): loaded http://localhost:56335/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56335/tests/dromaeo/cssquery-yui.html) 11:51:44 INFO - PID 17249 | RSS: Main: 166776832 11:51:44 INFO - PID 17249 | 11:54:46 INFO - PID 17249 | Cycle 1(1): loaded http://localhost:56335/tests/dromaeo/cssquery-yui.html (next: http://localhost:56335/tests/dromaeo/cssquery-dojo.html) 11:54:46 INFO - PID 17249 | RSS: Main: 169467904 11:54:46 INFO - PID 17249 | 11:54:46 INFO - PID 17249 | __start_tp_report 11:54:46 INFO - PID 17249 | _x_x_mozilla_page_load 11:54:46 INFO - PID 17249 | _x_x_mozilla_page_load_details 11:54:46 INFO - PID 17249 | |i|pagename|runs| 11:54:46 INFO - PID 17249 | |0;dojo.html;3900.648941595256;3912.3740201567753;3937.232239713256;3937.5471820740604;3954.367301231802;6281.089242059898;6295.493610343019;6350.809475715724;6470.288268290485;6480.12518310028;6381.936180638192;6400.9039864402075;6408.423241908227;6410.871782564346;6414.166158399413;5693.800716974907;5717.628354156987;5737.254156959611;5774.942250577504;5783.161441590988;5747.2241247431475;5758.0211364068;5785.681787501686;5789.942100578983;5790.189373487715;143.55256509988527;5568.693721845297;5620.9437905621035;5662.858428539278;5811.941880581204;5681.886362272773;5761.020626493506;5769.163471296639;5770.826875193751;5772.5670574707065;5668.574856885709;5683.971580142114;5724.5992780505385;5748.770049198027;5750.137479378085;6321.399467050623;6325.810225693236;6327.3988971047675;6335.144755458;6468.159139311906;6836.623985680785;6914.377706006433;6934.72261109555;6946.270641582662;6979.232284448706;6822.317768223187;6926.2034865990045;6929.376356127922;6991.230964593941;7007.229204787469;6456.935430645681;6492.772752953624;6503.512236582275;6514.44627206688;6520.347965203489;7073.080499535027;7100.68046937889;7163.42692584592;7185;7198.5680859148615;6715.731370745213;6793.320667933266;6797.320267973163;6878.931210687929;6888.758893438706;6882.483813713991;6917.204521479994;6949.270326615733;6973.860522789617;6998.720051197997;6806.081179040865;6863.862722745517;6872.587644741331;6917.757878474229;6927.445804335641;6847.691853866588;6877.312268773183;6962.3733863951475;6966.616836073963;6988.336108069725;4974.701517908937;4980.402351717745;4983.377077865267;5011.223260394645;5080.54275115234;4573.588377046081;4645.233536466513;4646.605038571759;4649.395578574831;4677.46209185948;6366.363363663597;6406.519511036598;6442.549021568539;6458.806235812933;6462.48300135988;6814.522983391115;6879.759208427681;6889.793306200822;6898.034275201476;6967.581945083311;6386.712597933104;6392.84017899547;6432.9385651367;6440.452561532322;6463.935360646427;5518.392976772552;5548.472895074961;5598.356189038313;5612.550995920316;5620.1288800236025;7034.718611255595;7125.180604230476;7133.357997780225;7143.7142514299885;7146.535475194096;6857.862842743117;6878.65606719652;6891.724331026703;6893.655317234218;6898.379145876695;7143.642817858982;7151.106111736033;7164.9641751790905;7167.928320716935;7290.635468226461;6827.556208846409;6849.657517124224;6916.23921368639;6933.618650974043;6953.721851125898;6945.2707465715375;6948.444124470131;7038.683259253244;7043.401310888632;7048.154221493453;6562.573432726857;6648.268690443951;6666.966665166643;6740.39336459721;6759.898601520883;6698.330166983263;6715.395614394728;6747.392734653905;6754.2570317266045;6769.864602708017;6607;6608.570442921195;6689.5986240825705;6694.096297000037;6702.530822842355;6703.061571380108;6711.429528489938;6712.899306510309;6734.427573656294;6818.897716534157;6462.4183823456115;6531.150950376421;6587.440067594308;6591.736330546724;6592.110065141144 11:54:46 INFO - PID 17249 | |1;ext.html;966.2897770138949;986.6596024371589;996.7508122969258;997.6907158780779;998.0418797953964;41640.79179604101;45424;45638.543614563845;45845.999999999956;45876.770616146954;42950.28198872049;43076.784616076955;43099.922501937464;43319.783401082954;43343.13313733724;7433.888491672629;7553.584552849591;7559.7354092606765;7562.092548894113;7567.621618919032;7401.518901271427;7428.257174282582;7496.8125796854965;7500.624968751541;7511;7465.701371945116;7496.850062998737;7502.662380192877;7513.699452021912;8014.398920081017;8111.391645626572;8155.10293867674;8158.347332213409;8172.795680108015;8172.918270817305;7976.880346794803;8065.6370463329295;8066.274035336789;8077.8788318175275;8081.595920204025;41134;41948.79025604852;42337.364939525934;42428.363574546405;42620;3714.238581090897;3747.7938713370754;3748.5314335708035;3750.887473375803;3751.362268414349;34011;34041.14897127567;34076.31847363039;34190.31619367623;34284.14289642779;5367.543758780508;5367.865803354908;5381.112116500773;5400.297961265011;5439.972800135974;190730;192614;192794;193390;194773;46168.769156154674;47136;51572.22641660378;51732.482675173516;54109.45890541123;55432.44567554354;55865;56003.71998139983;56085;56090;14958.62603434901;15085.622859428382;15095.54713358601;15114.773278400833;15184.392624295126;11884.643460696192;11926.642200733992;11955;11957.162998590189;11977.940110299392;15251.389944402099;15265.847341526665;15381.461648842236;15439.768403473958;15662.451814186677;5973.551983601247;5984.521238301013;6046.727897244635;6154.230721159855;6255.906161407583;1054.6730513540826;1071.8767341755797;1074.6399956014823;1085.6417382263835;1092.208149091918;25646.230613081636;25807.74192258091;25857.22428327153;26033.479330413287;26060.60909086365;1160.952499688318;1168.4099529737427;1170.414792603698;1174.512577280436;1184.6860581945791;13472.393742281622;13733.725325493435;13787.793183102262;13859.653508662162;13905.930470347786;254894;256081;256411;256781;257414;56502.71748641231;56937;56957.43042569604;56967.715161424756;56993;1462.3273294284747;1468.4346526587128;1496.4238768074151;1500.3398504657916;1516.795232643579;25114;25184.11855585046;25316.873415632803;25630.359241018377;25704.871475642503;39934.800325998185;39954;39972.80013599913;40007.1998560033;40069.59930400659;208871;209064;209150;209393;209960;36817.44773828341;38118.809405952794;39007.41488877726;39118.2176356477;39126.2174756509;51174.23238651349;51758.48241517687;51818.74090629523;51829.22256166085;52096.479035209166;37175.81412092922;37766.622333777406;37887.242255155295;38024;38038;36622;36630.267394651426;36911;36956.260874781816;37503.624963750015;43619.345709813744;43681.78159109184;43887.34168987404;43946.34080488731;44204.77897610491;35037.47443788396;35129.64870351264;35381.82309088438;35731.285374291845;35750.4637430444;26713.33216669599;26972.460550789267;27079.916803328433;27168.320791980357;27457.86271068632 11:54:46 INFO - PID 17249 | |2;jquery.html;590;602.0487629545318;609.3297372889824;611.3092205807437;625.3933684326204;23103.306900792963;23893.522129557397;23910.163144289952;23921.641175382385;24018.999999999978;22557.774422255774;24588;24619.63070553943;24661.013559457646;25014.87492562539;6675.699593518303;6829.521933464659;6835.248122706498;6838.760643377483;6842.55523390978;6477.54657173998;6739.831504212385;6748.156480439945;6756.932430675704;6760.459163266952;6658.600483970978;6713.597184168965;6718.865622687544;6733.360330768569;6733.8989915151315;6388.265349484822;6667.533272670915;6669.733210671568;6689.498287628423;6742.730290788362;6209.658468784215;6228.719707613123;6230.87538249237;6231.532635052344;6232.937670623326;29608.703912961024;30108.24729381783;30110.698893011227;30119;30123.548146777815;2237.3847192022163;2265.3543740034174;2265.716785401825;2266.2634643740685;2266.580682573729;19701;21098.261560845298;21138.471538211514;21141.577168456697;21167.153313867428;2496.1513085551;2526.090607381341;2563.9359016024564;2564.294818924792;2564.6922369315803;126891;133183;141983;149716;149747;15292.082475051533;15314.770278445832;15350.616234594001;15802.024746906636;15808.865803116432;24331.878340608182;24374.26877193687;24382.512349752906;24389.390265243157;24390.26829195127;9911.603535858485;9915.405075695482;9953.751156221153;9979.800403992025;10037;8943.508107054175;8978.910210897808;9025.50359730208;9034.774130646787;9093.4998575079;9302.302327325342;9652.324337296463;9678.75803104914;9712.5143742814;9761.07269809367;2880.481513327621;2926.4878646236825;2945.1017439681104;2971.242333205019;3058.2965917839024;1019.2712210769336;1031.85038169465;1040.8646875906236;1042.2756184451885;1043.4886905416292;20583.485412864797;20814;20939.58120837575;20983.55754857997;20984.467599642485;1032.3444612671008;1059.2849826367171;1073.1361254190297;1080.1358912869673;1086.1419478611965;11674.241174323643;11680.123990700731;11695.707607309716;11696.532138714527;11851.585194518151;519374;529024;549481;559617;563366;121938;124555;126084.36957815153;127693;128818.35590821986;1175.6590588729173;1183.4437814227472;1201.591458903977;1209.2079687804503;1213.1932265043647;18878.622427551647;19103.61792764109;19188.424347269603;19413;19629.11668974871;58809.4119058821;58850.411495886205;60001;60045;61384.386156139655;77384.61307693426;77387.61306193433;77432.61283693546;77777;78584.60707696425;15447.691046179238;15676.372945082068;15756.684866302381;15763.369465221722;15794.526164215093;23912.163074292315;23947.281581552583;23956.88021559881;24197.395065123514;24292.78536073154;18028.188731507376;18308.542286442946;19681.704774428108;20013.199472020955;20024.39926802198;17332.740008899626;17440.47678569645;17685.204165812826;17771.378001769877;17958.102094895465;18484.16821243074;18621.627567448846;18787.812121879153;18811.341603043827;20093.6985945208;15217.543473695807;15361.923190383977;15369;15374.077555346268;15374.461893833663;19492;19497;19686.90156549208;19846.305379311656;19857.404277871687 11:54:46 INFO - PID 17249 | |3;mootools.html;1436.0737324425745;1483.4807817263966;1485.8365579786227;1488.0922637191318;1494.7384207763641;16616.418425355114;17237.569060773487;17251;17323.566910827234;17348.21933013014;16889.071101089434;16914;17011.149442527887;17013.064281464514;17053.232604532794;2762.7513523782854;2817.0281252967798;2817.8591070446496;2819.6898341182455;2820.746132848043;2737.5893615957666;2817.7323154300307;2820.562812764025;2828.010196431253;2835.6455443069617;2642.960355594658;2857.157138644105;2857.385662082652;2857.6570811502647;2858.0568412423954;2839.6734375546766;2845.644294463192;2855.1434569629027;2857.0857325655797;2877.4101309231555;2808.7191280871953;2813.9859300703365;2817.788665850049;2820.562812764025;2826.5194916864184;16490.917545412198;16877.324907003705;16888.662226755398;16892.408765693264;16903.83096169035;7851.528908265465;8070.596470176468;8118.594070296521;8130.390220733469;8132.308753755938;5418.7019713915715;5563.610547261694;5658.603897727161;5714.542836573064;5759.308882934075;2051.292304155064;2104.2109209046607;2105.9473513162293;2131.4032071020138;2152.967705484419;30533.694663053306;30635.387292254254;30696.53955190674;30756;30941.535876962087;6897.448204143657;6980.581165130007;7000.124984376953;7011;7011.509194356346;19431.902840485705;19703.704444433344;19708.113134908963;19719.211231550576;19734.30929917446;8104.27061564462;8118.797030074295;8148.714794982147;8175.754727358189;8176.3867709922;7362.705491780376;7432.665530051161;7456.7762967111075;7467.626618669045;7509.324160825552;5545.639533430314;5805.303363596396;5822.417758224144;5841.970790146107;5885;1542.6066353079893;1545.3895711194016;1579.676166385888;1591.9204039797964;1621.7243068678354;924.5284904698652;933.486582379702;940.031767279703;947.696737044153;953.0993211415284;9043.59303831329;9049.457032578066;9070.410423322463;9151.17639412456;9283.535823208813;1025.876894772632;1028.7376718936773;1037.7042542875245;1041.3127335958231;1053.0943388685878;4735.360726301905;4773.164696178155;5036;5235.476452354734;5250.606204534675;25308.114216002352;25924.481510369686;25988.74011259901;26147.869260653955;26220.344491387867;24185.51628967411;25565.23304300874;25744.742552574608;25929.74070259273;25980.090696825897;11646.359450230319;12047.457864396123;12281.631551053482;12296.569620063256;12362.320072395925;9367;9412.623495060121;9549.665761698307;9623.759406014906;9625.470599117116;21004;21075.26236581712;21124.788752112898;21681.78318216861;22022.11911523521;21910.561788764455;21976.34070977873;22061;22111.44721381978;22244.221452249094;13269.734605307647;13604.65988350299;13715.177089374669;13715.862841371458;13724.039317247696;14785.334659940543;14917.925410372878;14970.17664028489;14989.475368362055;15003.549893502775;11370.829437558277;11932.701682458008;12493.18794278369;12578;12627.558035468715;11959.282443053444;11976.16166868311;12220.755584888075;12231.69420764488;12300;11080.556777729123;11144.665660030212;11207.439628018403;11253.66239012831;11273.605423810128;7776.494527855672;7896;7940.960295198487;8041.798955026171;8122.593870306343;7975.80060498469;8013;8022.237887400687;8054.637541310538;8209.958950205211 11:54:46 INFO - PID 17249 | |4;prototype.html;527.6939375162403;553.463140753469;564.7119968815903;564.7966731976488;566.7477972302324;6220.875582488347;6295.590786598874;6309.652969086698;6318.810435686931;6330.588511746739;6199.504039676826;6216.627002379849;6259.405356491137;6307.62154270744;6322.336154703758;5114.693118412898;5121.180611102224;5136.794528218867;5159.251908473288;5161.458046905059;4831.613470922335;5086.135356989321;5125.2312153176945;5125.461826508219;5146.047981123485;4879.707217566957;4908.926366104493;4917.40991081069;4931.334269873557;4973.328600638922;4892.192788189962;4913.803447862081;4916.58209052231;4937.037277730844;4960.578350840183;4332.133573285356;4449.866504004885;4484.461864576272;4486.8878278042985;4487.910241795146;6015.789447369321;6060.484858787008;6066.96966515169;6131.417515336036;6137.478314343286;5802.680852553108;5847.678377689225;5851.712623222884;5865.912011319833;5887.411258874121;6624.7412991531455;6656.36764507371;6677.666116694194;6731.158605174353;6733.653269346101;5035.899282014376;5039;5042.924356134661;5056.494350564951;5079.720615366154;6777.457803375718;6820.761273355409;6868.656567171622;6926.757563485254;6981.5461994970165;5112.667676601009;5142.61430392722;5206.7564934578195;5211.212001579137;5219;5212.478752124757;5261.105612045962;5286.497782710637;5291.735413229323;5301.390340110859;5768.7692492300675;5771.192033115367;5814.360420353758;5844.6785426801935;5848.777464563439;6634.900476492857;6720.831979200461;6732.831679208059;6742.584057348012;6767.966160169168;1799.1543974332044;1808.538822600255;1818.8908665480114;1825.4797382745853;1838.4576549917806;1239.5599562155485;1240.2670734848434;1258.2199036597185;1288.2978776566792;1291.7674818532566;6228.377162283736;6229.595076320024;6248;6274.341194174637;6287;6686.531942764057;6804.217514985741;6814.829629259309;6837.974303854362;6859.878755166387;6009.909851352233;6112.8777424452155;6148.661823599745;6239.438450539383;6282.685865706788;3506.561679790026;3547.7161827053774;3552.484889691032;3569.785812851237;3585.8924232273075;6888.311168883171;6920.757773477904;6927.688254028581;7015.964920175366;7033.4724895633035;6878.621675807879;6930.965345173242;6958.130233720785;6972.442204623618;6989.231184569693;7082.610456424843;7090.042844216068;7099.2545782693105;7101.893471598033;7106.857862842714;6811.182658081062;6826.658667066726;6839.487038472234;6868.347506986828;6875.3812156906115;6751.7171737369745;6791.830204244736;6815.488838337244;6823;6836.589804611739;7023.331134168983;7025.613591252531;7090.255523170199;7147.392471639969;7147.821304467222;5198.142306519533;5206.349206349207;5214.530692237717;5234.502722241381;5239.580833533232;6545.8690826184165;6673.731990921709;6747.527673063035;6785.185777706707;6851.143607049119;6473.287938326686;6562.981028726648;6589.0116482528;6602.471802255904;6604.570702904488;6504.60972341661;6514.51141164424;6558.508111891531;6593.208814942238;6619.172603424572;6452.870942581216;6464.41820236181;6536.967315163393;6538.280789113289;6580.802575922538;6580.144581204413;6636.767713130017;6644.335566443317;6646.60120392778;6670.866582668416;6400.71196796136;6401.303654531646;6458.451031662361;6479.352064793483;6494.545381823227 11:54:46 INFO - PID 17249 | |5;yui.html;988.9851652225213;989.3272574649238;1004.0963133180137;1009.8283291840387;1012.2610494339137;18874.43376698698;19398.903005484954;19399.418017459462;19421;19431.41705748828;16104.919475402636;16106.114163720991;16132.435364762236;16155;16156.75764863528;1043.572135424476;1075.2903083964584;1075.4085253110798;1077.466654006268;1078.062085985192;1094.9980767597638;1097.0729733375285;1097.6322931817851;1097.736543229623;1098.1379617000657;1067.770429357688;1106.065374758332;1110.639042311248;1117.7876203521346;1120.512577028991;1108.8558487396626;1113.3653817324127;1113.6603335982522;1113.9944300278487;1114.9275297105703;796.665400531778;813.589137485566;816.9101398846122;818.8689809630431;831.6257684042205;21052.368428947157;21296.361109166595;21305.786942130537;21366.679499807517;21382.67925981096;22694.659580106312;22817.543649126925;23086.307410777703;23328.533429331317;23341.53316933669;17629.206685699173;17665.38171164003;17694.646107077915;17772.200250988735;17873.463796086136;3969.364901615728;3997.1006523532265;3999.0202400412086;4001.339778936472;4002.3596224603925;125145;157688;158254;159513;160701;18017.819821801615;18568;18668.253269869052;18685.532861678294;18765.155567999474;33641.49537756936;33748.66251337504;33899;34473.13817154541;34482.310353793284;10221.080102790784;10294.124999374988;10319.74200644975;10428.739281518023;10448.111910487542;4653.674242803039;4693.084848454587;4738.19450693383;4743.857684269477;4758.976205118952;5933;6037.094435834572;6043.909341359883;6060.363661815534;6081.118237855486;1282.538286216961;1296.1056870759335;1308.8363954505687;1312.4225340849996;1319.2546211390534;735.6946867050115;741.3105811595268;748.098541257783;756.9053868266467;763.694522191128;13240.470381184645;13412.664683382798;13603.047786655037;14001.089929154572;14026.158430494203;741.1328745367932;750.1748077115129;751.4589495563185;755.7704770925791;762.954222746637;5838.766449341979;5859.589828712034;5867.794627188028;5997.340292567814;6066.363031881677;147961;150111;151064;151284.48715512923;151824;100626;127175.36412317879;134400;137829;138010;111083.44458277657;111830;112113;112329.87670123357;114261;14654.340554675278;14895.851041489446;14931.776023359875;15064.924675376553;15078.849211507744;53401.46598533965;53979;54643.18035229395;56027.71986140043;56160.43839561552;71598;71807.64096179485;72511;72868.27131728615;73011.63494182494;18693.158807853408;18770.6245875079;18842.811571884107;18871;19028.143733532303;22877.542449151257;23049.617022978004;23218.65172022455;23480.295591132293;23505.412364690335;20811.8959405202;21270.680939785605;21308.680369794154;21415.357539273846;21606.2437814682;19748.90125549363;19829.504262393555;19842;19875.503112422306;19892.60214795725;18903.621927561646;18909.149088290786;18961.525961851064;19167.32914348047;19198.71201932;14381.42474301058;14496.275186240435;14791.852081479048;14878.10731356122;14892.7766083511;14674.70650586961;14840.10959342443;15068.472603458826;15072.849271507583;15093 11:54:46 INFO - PID 17249 | __end_tp_report 11:54:46 INFO - PID 17249 | __start_cc_report 11:54:46 INFO - PID 17249 | _x_x_mozilla_cycle_collect,351 11:54:46 INFO - PID 17249 | __end_cc_report 11:54:46 INFO - PID 17249 | __startTimestamp1505069686613__endTimestamp 11:54:46 INFO - PID 17249 | 11:54:46 INFO - PID 17249 | ------- Summary: start ------- 11:54:46 INFO - PID 17249 | Number of tests: 6 11:54:46 INFO - PID 17249 | 11:54:46 INFO - PID 17249 | [#0] dojo.html Cycles:165 Average:6335.85 Median:6608.57 stddev:897.97 (13.6%) stddev-sans-first:880.17 11:54:46 INFO - PID 17249 | Values: 3900.6 3912.4 3937.2 3937.5 3954.4 6281.1 6295.5 6350.8 6470.3 6480.1 6381.9 6400.9 6408.4 6410.9 6414.2 5693.8 5717.6 5737.3 5774.9 5783.2 5747.2 5758.0 5785.7 5789.9 5790.2 143.6 5568.7 5620.9 5662.9 5811.9 5681.9 5761.0 5769.2 5770.8 5772.6 5668.6 5684.0 5724.6 5748.8 5750.1 6321.4 6325.8 6327.4 6335.1 6468.2 6836.6 6914.4 6934.7 6946.3 6979.2 6822.3 6926.2 6929.4 6991.2 7007.2 6456.9 6492.8 6503.5 6514.4 6520.3 7073.1 7100.7 7163.4 7185.0 7198.6 6715.7 6793.3 6797.3 6878.9 6888.8 6882.5 6917.2 6949.3 6973.9 6998.7 6806.1 6863.9 6872.6 6917.8 6927.4 6847.7 6877.3 6962.4 6966.6 6988.3 4974.7 4980.4 4983.4 5011.2 5080.5 4573.6 4645.2 4646.6 4649.4 4677.5 6366.4 6406.5 6442.5 6458.8 6462.5 6814.5 6879.8 6889.8 6898.0 6967.6 6386.7 6392.8 6432.9 6440.5 6463.9 5518.4 5548.5 5598.4 5612.6 5620.1 7034.7 7125.2 7133.4 7143.7 7146.5 6857.9 6878.7 6891.7 6893.7 6898.4 7143.6 7151.1 7165.0 7167.9 7290.6 6827.6 6849.7 6916.2 6933.6 6953.7 6945.3 6948.4 7038.7 7043.4 7048.2 6562.6 6648.3 6667.0 6740.4 6759.9 6698.3 6715.4 6747.4 6754.3 6769.9 6607.0 6608.6 6689.6 6694.1 6702.5 6703.1 6711.4 6712.9 6734.4 6818.9 6462.4 6531.2 6587.4 6591.7 6592.1 11:54:46 INFO - PID 17249 | 11:54:46 INFO - PID 17249 | [#1] ext.html Cycles:180 Average:40640.32 Median:38078.40 stddev:57385.14 (150.7%) stddev-sans-first:57468.79 11:54:46 INFO - PID 17249 | Values: 966.3 986.7 996.8 997.7 998.0 41640.8 45424.0 45638.5 45846.0 45876.8 42950.3 43076.8 43099.9 43319.8 43343.1 7433.9 7553.6 7559.7 7562.1 7567.6 7401.5 7428.3 7496.8 7500.6 7511.0 7465.7 7496.9 7502.7 7513.7 8014.4 8111.4 8155.1 8158.3 8172.8 8172.9 7976.9 8065.6 8066.3 8077.9 8081.6 41134.0 41948.8 42337.4 42428.4 42620.0 3714.2 3747.8 3748.5 3750.9 3751.4 34011.0 34041.1 34076.3 34190.3 34284.1 5367.5 5367.9 5381.1 5400.3 5440.0 190730.0 192614.0 192794.0 193390.0 194773.0 46168.8 47136.0 51572.2 51732.5 54109.5 55432.4 55865.0 56003.7 56085.0 56090.0 14958.6 15085.6 15095.5 15114.8 15184.4 11884.6 11926.6 11955.0 11957.2 11977.9 15251.4 15265.8 15381.5 15439.8 15662.5 5973.6 5984.5 6046.7 6154.2 6255.9 1054.7 1071.9 1074.6 1085.6 1092.2 25646.2 25807.7 25857.2 26033.5 26060.6 1161.0 1168.4 1170.4 1174.5 1184.7 13472.4 13733.7 13787.8 13859.7 13905.9 254894.0 256081.0 256411.0 256781.0 257414.0 56502.7 56937.0 56957.4 56967.7 56993.0 1462.3 1468.4 1496.4 1500.3 1516.8 25114.0 25184.1 25316.9 25630.4 25704.9 39934.8 39954.0 39972.8 40007.2 40069.6 208871.0 209064.0 209150.0 209393.0 209960.0 36817.4 38118.8 39007.4 39118.2 39126.2 51174.2 51758.5 51818.7 51829.2 52096.5 37175.8 37766.6 37887.2 38024.0 38038.0 36622.0 36630.3 36911.0 36956.3 37503.6 43619.3 43681.8 43887.3 43946.3 44204.8 35037.5 35129.6 35381.8 35731.3 35750.5 26713.3 26972.5 27079.9 27168.3 27457.9 11:54:46 INFO - PID 17249 | 11:54:46 INFO - PID 17249 | [#2] jquery.html Cycles:180 Average:37287.85 Median:23916.90 stddev:91367.92 (382.0%) stddev-sans-first:91582.68 11:54:46 INFO - PID 17249 | Values: 590.0 602.0 609.3 611.3 625.4 23103.3 23893.5 23910.2 23921.6 24019.0 22557.8 24588.0 24619.6 24661.0 25014.9 6675.7 6829.5 6835.2 6838.8 6842.6 6477.5 6739.8 6748.2 6756.9 6760.5 6658.6 6713.6 6718.9 6733.4 6733.9 6388.3 6667.5 6669.7 6689.5 6742.7 6209.7 6228.7 6230.9 6231.5 6232.9 29608.7 30108.2 30110.7 30119.0 30123.5 2237.4 2265.4 2265.7 2266.3 2266.6 19701.0 21098.3 21138.5 21141.6 21167.2 2496.2 2526.1 2563.9 2564.3 2564.7 126891.0 133183.0 141983.0 149716.0 149747.0 15292.1 15314.8 15350.6 15802.0 15808.9 24331.9 24374.3 24382.5 24389.4 24390.3 9911.6 9915.4 9953.8 9979.8 10037.0 8943.5 8978.9 9025.5 9034.8 9093.5 9302.3 9652.3 9678.8 9712.5 9761.1 2880.5 2926.5 2945.1 2971.2 3058.3 1019.3 1031.9 1040.9 1042.3 1043.5 20583.5 20814.0 20939.6 20983.6 20984.5 1032.3 1059.3 1073.1 1080.1 1086.1 11674.2 11680.1 11695.7 11696.5 11851.6 519374.0 529024.0 549481.0 559617.0 563366.0 121938.0 124555.0 126084.4 127693.0 128818.4 1175.7 1183.4 1201.6 1209.2 1213.2 18878.6 19103.6 19188.4 19413.0 19629.1 58809.4 58850.4 60001.0 60045.0 61384.4 77384.6 77387.6 77432.6 77777.0 78584.6 15447.7 15676.4 15756.7 15763.4 15794.5 23912.2 23947.3 23956.9 24197.4 24292.8 18028.2 18308.5 19681.7 20013.2 20024.4 17332.7 17440.5 17685.2 17771.4 17958.1 18484.2 18621.6 18787.8 18811.3 20093.7 15217.5 15361.9 15369.0 15374.1 15374.5 19492.0 19497.0 19686.9 19846.3 19857.4 11:54:46 INFO - PID 17249 | 11:54:46 INFO - PID 17249 | [#3] mootools.html Cycles:180 Average:10424.47 Median:2690.27 stddev:7846.12 (291.6%) stddev-sans-first:7839.08 11:54:46 INFO - PID 17249 | Values: 1436.1 1483.5 1485.8 1488.1 1494.7 16616.4 17237.6 17251.0 17323.6 17348.2 16889.1 16914.0 17011.1 17013.1 17053.2 2762.8 2817.0 2817.9 2819.7 2820.7 2737.6 2817.7 2820.6 2828.0 2835.6 2643.0 2857.2 2857.4 2857.7 2858.1 2839.7 2845.6 2855.1 2857.1 2877.4 2808.7 2814.0 2817.8 2820.6 2826.5 16490.9 16877.3 16888.7 16892.4 16903.8 7851.5 8070.6 8118.6 8130.4 8132.3 5418.7 5563.6 5658.6 5714.5 5759.3 2051.3 2104.2 2105.9 2131.4 2153.0 30533.7 30635.4 30696.5 30756.0 30941.5 6897.4 6980.6 7000.1 7011.0 7011.5 19431.9 19703.7 19708.1 19719.2 19734.3 8104.3 8118.8 8148.7 8175.8 8176.4 7362.7 7432.7 7456.8 7467.6 7509.3 5545.6 5805.3 5822.4 5842.0 5885.0 1542.6 1545.4 1579.7 1591.9 1621.7 924.5 933.5 940.0 947.7 953.1 9043.6 9049.5 9070.4 9151.2 9283.5 1025.9 1028.7 1037.7 1041.3 1053.1 4735.4 4773.2 5036.0 5235.5 5250.6 25308.1 25924.5 25988.7 26147.9 26220.3 24185.5 25565.2 25744.7 25929.7 25980.1 11646.4 12047.5 12281.6 12296.6 12362.3 9367.0 9412.6 9549.7 9623.8 9625.5 21004.0 21075.3 21124.8 21681.8 22022.1 21910.6 21976.3 22061.0 22111.4 22244.2 13269.7 13604.7 13715.2 13715.9 13724.0 14785.3 14917.9 14970.2 14989.5 15003.5 11370.8 11932.7 12493.2 12578.0 12627.6 11959.3 11976.2 12220.8 12231.7 12300.0 11080.6 11144.7 11207.4 11253.7 11273.6 7776.5 7896.0 7941.0 8041.8 8122.6 7975.8 8013.0 8022.2 8054.6 8210.0 11:54:46 INFO - PID 17249 | 11:54:46 INFO - PID 17249 | [#4] prototype.html Cycles:180 Average:5649.23 Median:6266.87 stddev:1590.40 (25.4%) stddev-sans-first:1547.71 11:54:46 INFO - PID 17249 | Values: 527.7 553.5 564.7 564.8 566.7 6220.9 6295.6 6309.7 6318.8 6330.6 6199.5 6216.6 6259.4 6307.6 6322.3 5114.7 5121.2 5136.8 5159.3 5161.5 4831.6 5086.1 5125.2 5125.5 5146.0 4879.7 4908.9 4917.4 4931.3 4973.3 4892.2 4913.8 4916.6 4937.0 4960.6 4332.1 4449.9 4484.5 4486.9 4487.9 6015.8 6060.5 6067.0 6131.4 6137.5 5802.7 5847.7 5851.7 5865.9 5887.4 6624.7 6656.4 6677.7 6731.2 6733.7 5035.9 5039.0 5042.9 5056.5 5079.7 6777.5 6820.8 6868.7 6926.8 6981.5 5112.7 5142.6 5206.8 5211.2 5219.0 5212.5 5261.1 5286.5 5291.7 5301.4 5768.8 5771.2 5814.4 5844.7 5848.8 6634.9 6720.8 6732.8 6742.6 6768.0 1799.2 1808.5 1818.9 1825.5 1838.5 1239.6 1240.3 1258.2 1288.3 1291.8 6228.4 6229.6 6248.0 6274.3 6287.0 6686.5 6804.2 6814.8 6838.0 6859.9 6009.9 6112.9 6148.7 6239.4 6282.7 3506.6 3547.7 3552.5 3569.8 3585.9 6888.3 6920.8 6927.7 7016.0 7033.5 6878.6 6931.0 6958.1 6972.4 6989.2 7082.6 7090.0 7099.3 7101.9 7106.9 6811.2 6826.7 6839.5 6868.3 6875.4 6751.7 6791.8 6815.5 6823.0 6836.6 7023.3 7025.6 7090.3 7147.4 7147.8 5198.1 5206.3 5214.5 5234.5 5239.6 6545.9 6673.7 6747.5 6785.2 6851.1 6473.3 6563.0 6589.0 6602.5 6604.6 6504.6 6514.5 6558.5 6593.2 6619.2 6452.9 6464.4 6537.0 6538.3 6580.8 6580.1 6636.8 6644.3 6646.6 6670.9 6400.7 6401.3 6458.5 6479.4 6494.5 11:54:46 INFO - PID 17249 | 11:54:46 INFO - PID 17249 | [#5] yui.html Cycles:180 Average:28343.96 Median:18856.91 stddev:41291.93 (219.0%) stddev-sans-first:41356.68 11:54:46 INFO - PID 17249 | Values: 989.0 989.3 1004.1 1009.8 1012.3 18874.4 19398.9 19399.4 19421.0 19431.4 16104.9 16106.1 16132.4 16155.0 16156.8 1043.6 1075.3 1075.4 1077.5 1078.1 1095.0 1097.1 1097.6 1097.7 1098.1 1067.8 1106.1 1110.6 1117.8 1120.5 1108.9 1113.4 1113.7 1114.0 1114.9 796.7 813.6 816.9 818.9 831.6 21052.4 21296.4 21305.8 21366.7 21382.7 22694.7 22817.5 23086.3 23328.5 23341.5 17629.2 17665.4 17694.6 17772.2 17873.5 3969.4 3997.1 3999.0 4001.3 4002.4 125145.0 157688.0 158254.0 159513.0 160701.0 18017.8 18568.0 18668.3 18685.5 18765.2 33641.5 33748.7 33899.0 34473.1 34482.3 10221.1 10294.1 10319.7 10428.7 10448.1 4653.7 4693.1 4738.2 4743.9 4759.0 5933.0 6037.1 6043.9 6060.4 6081.1 1282.5 1296.1 1308.8 1312.4 1319.3 735.7 741.3 748.1 756.9 763.7 13240.5 13412.7 13603.0 14001.1 14026.2 741.1 750.2 751.5 755.8 763.0 5838.8 5859.6 5867.8 5997.3 6066.4 147961.0 150111.0 151064.0 151284.5 151824.0 100626.0 127175.4 134400.0 137829.0 138010.0 111083.4 111830.0 112113.0 112329.9 114261.0 14654.3 14895.9 14931.8 15064.9 15078.8 53401.5 53979.0 54643.2 56027.7 56160.4 71598.0 71807.6 72511.0 72868.3 73011.6 18693.2 18770.6 18842.8 18871.0 19028.1 22877.5 23049.6 23218.7 23480.3 23505.4 20811.9 21270.7 21308.7 21415.4 21606.2 19748.9 19829.5 19842.0 19875.5 19892.6 18903.6 18909.1 18961.5 19167.3 19198.7 14381.4 14496.3 14791.9 14878.1 14892.8 14674.7 14840.1 15068.5 15072.8 15093.0 11:54:46 INFO - PID 17249 | -------- Summary: end -------- 11:54:46 INFO - PID 17249 | 11:54:47 INFO - TEST-INFO | 17249: exit 0 11:54:47 INFO - TEST-OK | dromaeo_css | took 1106348ms 11:54:47 INFO - TEST-START | kraken 11:54:47 INFO - Initialising browser for kraken test... 11:54:47 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:56335/getInfo.html -profile /tmp/tmpHjxBe_/profile 11:54:47 INFO - TEST-INFO | started process 17643 (/builds/slave/test/build/application/firefox/firefox http://localhost:56335/getInfo.html) 11:54:51 INFO - TEST-INFO | 17643: exit 0 11:54:51 INFO - Browser initialized. 11:54:51 INFO - Running cycle 1/1 for kraken test... 11:54:51 INFO - Using env: {'DISPLAY': ':0', 11:54:51 INFO - 'HOME': '/home/cltbld', 11:54:51 INFO - 'JSGC_DISABLE_POISONING': '1', 11:54:51 INFO - 'LANG': 'en_US.UTF-8', 11:54:51 INFO - 'LANGUAGE': 'en_US:en', 11:54:51 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:54:51 INFO - 'LOGNAME': 'cltbld', 11:54:51 INFO - 'MAIL': '/var/mail/cltbld', 11:54:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:54:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:54:51 INFO - 'MOZ_CRASHREPORTER': '1', 11:54:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:51 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:54:51 INFO - 'MOZ_NO_REMOTE': '1', 11:54:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:54:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:54:51 INFO - 'NO_EM_RESTART': '1', 11:54:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:54:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:54:51 INFO - 'PWD': '/builds/slave/test', 11:54:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:54:51 INFO - 'RUST_BACKTRACE': 'full', 11:54:51 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:54:51 INFO - 'SHELL': '/bin/bash', 11:54:51 INFO - 'SHLVL': '1', 11:54:51 INFO - 'TERM': 'linux', 11:54:51 INFO - 'TMOUT': '86400', 11:54:51 INFO - 'USER': 'cltbld', 11:54:51 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1505067859.53232-898075472', 11:54:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:51 INFO - '_': '/tools/buildbot/bin/python'} 11:54:51 INFO - TEST-INFO | started process 17844 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHjxBe_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:54:52 INFO - PID 17844 | 11:54:52 INFO - PID 17844 | (/builds/slave/test/build/application/firefox/firefox:17895): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:54:52 INFO - PID 17844 | 11:55:02 INFO - PID 17844 | RSS: Main: 166232064 11:55:02 INFO - PID 17844 | 11:55:05 INFO - PID 17844 | Cycle 1(1): loaded http://localhost:56335/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56335/tests/kraken/driver.html?testName=audio-beat-detection) 11:55:06 INFO - PID 17844 | RSS: Main: 171683840 11:55:06 INFO - PID 17844 | 11:55:09 INFO - PID 17844 | Cycle 1(1): loaded http://localhost:56335/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56335/tests/kraken/driver.html?testName=audio-dft) 11:55:09 INFO - PID 17844 | RSS: Main: 171970560 11:55:09 INFO - PID 17844 | 11:55:12 INFO - PID 17844 | Cycle 1(1): loaded http://localhost:56335/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56335/tests/kraken/driver.html?testName=audio-fft) 11:55:13 INFO - PID 17844 | RSS: Main: 166965248 11:55:13 INFO - PID 17844 | 11:55:15 INFO - PID 17844 | Cycle 1(1): loaded http://localhost:56335/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56335/tests/kraken/driver.html?testName=audio-oscillator) 11:55:15 INFO - PID 17844 | RSS: Main: 168169472 11:55:15 INFO - PID 17844 | 11:55:17 INFO - PID 17844 | Cycle 1(1): loaded http://localhost:56335/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56335/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:55:18 INFO - PID 17844 | RSS: Main: 168439808 11:55:18 INFO - PID 17844 | 11:55:21 INFO - PID 17844 | Cycle 1(1): loaded http://localhost:56335/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56335/tests/kraken/driver.html?testName=imaging-darkroom) 11:55:22 INFO - PID 17844 | RSS: Main: 171679744 11:55:22 INFO - PID 17844 | 11:55:25 INFO - PID 17844 | Cycle 1(1): loaded http://localhost:56335/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56335/tests/kraken/driver.html?testName=imaging-desaturate) 11:55:26 INFO - PID 17844 | RSS: Main: 170352640 11:55:26 INFO - PID 17844 | 11:55:29 INFO - PID 17844 | Cycle 1(1): loaded http://localhost:56335/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56335/tests/kraken/driver.html?testName=json-parse-financial) 11:55:30 INFO - PID 17844 | RSS: Main: 171016192 11:55:30 INFO - PID 17844 | 11:55:31 INFO - PID 17844 | Cycle 1(1): loaded http://localhost:56335/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56335/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:55:32 INFO - PID 17844 | RSS: Main: 170995712 11:55:32 INFO - PID 17844 | 11:55:33 INFO - PID 17844 | Cycle 1(1): loaded http://localhost:56335/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56335/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:55:34 INFO - PID 17844 | RSS: Main: 170958848 11:55:34 INFO - PID 17844 | 11:55:36 INFO - PID 17844 | Cycle 1(1): loaded http://localhost:56335/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56335/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:55:37 INFO - PID 17844 | RSS: Main: 168046592 11:55:37 INFO - PID 17844 | 11:55:39 INFO - PID 17844 | Cycle 1(1): loaded http://localhost:56335/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56335/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:55:40 INFO - PID 17844 | RSS: Main: 168210432 11:55:40 INFO - PID 17844 | 11:55:43 INFO - PID 17844 | Cycle 1(1): loaded http://localhost:56335/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56335/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:55:43 INFO - PID 17844 | RSS: Main: 168751104 11:55:43 INFO - PID 17844 | 11:55:45 INFO - PID 17844 | Cycle 1(1): loaded http://localhost:56335/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56335/tests/kraken/driver.html?testName=ai-astar) 11:55:45 INFO - PID 17844 | RSS: Main: 170135552 11:55:45 INFO - PID 17844 | 11:55:45 INFO - PID 17844 | __start_tp_report 11:55:45 INFO - PID 17844 | _x_x_mozilla_page_load 11:55:45 INFO - PID 17844 | _x_x_mozilla_page_load_details 11:55:45 INFO - PID 17844 | |i|pagename|runs| 11:55:45 INFO - PID 17844 | |0;ai-astar;107;105;105;105;105;115;105;105;104;112 11:55:45 INFO - PID 17844 | |1;audio-beat-detection;123;114;114;116;115;114;115;113;113;112 11:55:45 INFO - PID 17844 | |2;audio-dft;163;161;164;162;164;162;161;162;165;164 11:55:45 INFO - PID 17844 | |3;audio-fft;73;74;74;74;73;73;73;73;72;74 11:55:45 INFO - PID 17844 | |4;audio-oscillator;86;79;80;77;77;77;81;81;79;83 11:55:45 INFO - PID 17844 | |5;imaging-gaussian-blur;113;114;114;113;110;113;114;113;115;113 11:55:45 INFO - PID 17844 | |6;imaging-darkroom;150;150;151;150;150;149;149;148;148;150 11:55:45 INFO - PID 17844 | |7;imaging-desaturate;98;94;94;93;94;94;96;94;95;95 11:55:45 INFO - PID 17844 | |8;json-parse-financial;47;44;47;46;45;45;44;43;47;43 11:55:45 INFO - PID 17844 | |9;json-stringify-tinderbox;51;51;47;47;49;48;47;47;48;48 11:55:45 INFO - PID 17844 | |10;stanford-crypto-aes;74;74;72;72;76;77;73;71;71;71 11:55:45 INFO - PID 17844 | |11;stanford-crypto-ccm;111;109;133;118;109;113;117;111;119;116 11:55:45 INFO - PID 17844 | |12;stanford-crypto-pbkdf2;166;160;152;153;155;163;149;161;150;151 11:55:45 INFO - PID 17844 | |13;stanford-crypto-sha256-iterative;59;58;60;61;60;59;58;61;58;58 11:55:45 INFO - PID 17844 | __end_tp_report 11:55:45 INFO - PID 17844 | __start_cc_report 11:55:45 INFO - PID 17844 | _x_x_mozilla_cycle_collect,913 11:55:45 INFO - PID 17844 | __end_cc_report 11:55:45 INFO - PID 17844 | __startTimestamp1505069745686__endTimestamp 11:55:45 INFO - PID 17844 | 11:55:45 INFO - PID 17844 | ------- Summary: start ------- 11:55:45 INFO - PID 17844 | Number of tests: 14 11:55:45 INFO - PID 17844 | 11:55:45 INFO - PID 17844 | [#0] ai-astar Cycles:10 Average:106.80 Median:105.00 stddev:3.68 (3.5%) stddev-sans-first:3.90 11:55:45 INFO - PID 17844 | Values: 107.0 105.0 105.0 105.0 105.0 115.0 105.0 105.0 104.0 112.0 11:55:45 INFO - PID 17844 | 11:55:45 INFO - PID 17844 | [#1] audio-beat-detection Cycles:10 Average:114.90 Median:114.50 stddev:3.07 (2.7%) stddev-sans-first:1.22 11:55:45 INFO - PID 17844 | Values: 123.0 114.0 114.0 116.0 115.0 114.0 115.0 113.0 113.0 112.0 11:55:45 INFO - PID 17844 | 11:55:45 INFO - PID 17844 | [#2] audio-dft Cycles:10 Average:162.80 Median:163.50 stddev:1.40 (0.9%) stddev-sans-first:1.48 11:55:45 INFO - PID 17844 | Values: 163.0 161.0 164.0 162.0 164.0 162.0 161.0 162.0 165.0 164.0 11:55:45 INFO - PID 17844 | 11:55:45 INFO - PID 17844 | [#3] audio-fft Cycles:10 Average:73.30 Median:73.50 stddev:0.67 (0.9%) stddev-sans-first:0.71 11:55:45 INFO - PID 17844 | Values: 73.0 74.0 74.0 74.0 73.0 73.0 73.0 73.0 72.0 74.0 11:55:45 INFO - PID 17844 | 11:55:45 INFO - PID 17844 | [#4] audio-oscillator Cycles:10 Average:80.00 Median:80.50 stddev:2.91 (3.6%) stddev-sans-first:2.12 11:55:45 INFO - PID 17844 | Values: 86.0 79.0 80.0 77.0 77.0 77.0 81.0 81.0 79.0 83.0 11:55:45 INFO - PID 17844 | 11:55:45 INFO - PID 17844 | [#5] imaging-gaussian-blur Cycles:10 Average:113.20 Median:113.50 stddev:1.32 (1.2%) stddev-sans-first:1.39 11:55:45 INFO - PID 17844 | Values: 113.0 114.0 114.0 113.0 110.0 113.0 114.0 113.0 115.0 113.0 11:55:45 INFO - PID 17844 | 11:55:45 INFO - PID 17844 | [#6] imaging-darkroom Cycles:10 Average:149.50 Median:150.00 stddev:0.97 (0.6%) stddev-sans-first:1.01 11:55:45 INFO - PID 17844 | Values: 150.0 150.0 151.0 150.0 150.0 149.0 149.0 148.0 148.0 150.0 11:55:45 INFO - PID 17844 | 11:55:45 INFO - PID 17844 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:94.50 stddev:1.42 (1.5%) stddev-sans-first:0.87 11:55:45 INFO - PID 17844 | Values: 98.0 94.0 94.0 93.0 94.0 94.0 96.0 94.0 95.0 95.0 11:55:45 INFO - PID 17844 | 11:55:45 INFO - PID 17844 | [#8] json-parse-financial Cycles:10 Average:45.10 Median:45.50 stddev:1.60 (3.5%) stddev-sans-first:1.54 11:55:45 INFO - PID 17844 | Values: 47.0 44.0 47.0 46.0 45.0 45.0 44.0 43.0 47.0 43.0 11:55:45 INFO - PID 17844 | 11:55:45 INFO - PID 17844 | [#9] json-stringify-tinderbox Cycles:10 Average:48.30 Median:48.00 stddev:1.57 (3.3%) stddev-sans-first:1.32 11:55:45 INFO - PID 17844 | Values: 51.0 51.0 47.0 47.0 49.0 48.0 47.0 47.0 48.0 48.0 11:55:45 INFO - PID 17844 | 11:55:45 INFO - PID 17844 | [#10] stanford-crypto-aes Cycles:10 Average:73.10 Median:73.50 stddev:2.13 (2.9%) stddev-sans-first:2.24 11:55:45 INFO - PID 17844 | Values: 74.0 74.0 72.0 72.0 76.0 77.0 73.0 71.0 71.0 71.0 11:55:45 INFO - PID 17844 | 11:55:45 INFO - PID 17844 | [#11] stanford-crypto-ccm Cycles:10 Average:115.60 Median:116.50 stddev:7.14 (6.1%) stddev-sans-first:7.37 11:55:45 INFO - PID 17844 | Values: 111.0 109.0 133.0 118.0 109.0 113.0 117.0 111.0 119.0 116.0 11:55:45 INFO - PID 17844 | 11:55:45 INFO - PID 17844 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.00 Median:157.50 stddev:6.02 (3.8%) stddev-sans-first:5.18 11:55:45 INFO - PID 17844 | Values: 166.0 160.0 152.0 153.0 155.0 163.0 149.0 161.0 150.0 151.0 11:55:45 INFO - PID 17844 | 11:55:45 INFO - PID 17844 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:59.20 Median:59.50 stddev:1.23 (2.1%) stddev-sans-first:1.30 11:55:45 INFO - PID 17844 | Values: 59.0 58.0 60.0 61.0 60.0 59.0 58.0 61.0 58.0 58.0 11:55:45 INFO - PID 17844 | -------- Summary: end -------- 11:55:45 INFO - PID 17844 | 11:55:46 INFO - PID 17844 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:55:46 INFO - TEST-INFO | 17844: exit 0 11:55:46 INFO - TEST-OK | kraken | took 59039ms 11:55:46 INFO - SUITE-END | took 1165s 11:55:46 INFO - Completed test suite (00:19:25) 11:55:46 INFO - javascript benchmark 11:55:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9067.77453596224, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3900.648941595256, 3912.3740201567753, 3937.232239713256, 3937.5471820740604, 3954.367301231802, 6281.089242059898, 6295.493610343019, 6350.809475715724, 6470.288268290485, 6480.12518310028, 6381.936180638192, 6400.9039864402075, 6408.423241908227, 6410.871782564346, 6414.166158399413, 5693.800716974907, 5717.628354156987, 5737.254156959611, 5774.942250577504, 5783.161441590988, 5747.2241247431475, 5758.0211364068, 5785.681787501686, 5789.942100578983, 5790.189373487715, 143.55256509988527, 5568.693721845297, 5620.9437905621035, 5662.858428539278, 5811.941880581204, 5681.886362272773, 5761.020626493506, 5769.163471296639, 5770.826875193751, 5772.5670574707065, 5668.574856885709, 5683.971580142114, 5724.5992780505385, 5748.770049198027, 5750.137479378085, 6321.399467050623, 6325.810225693236, 6327.3988971047675, 6335.144755458, 6468.159139311906, 6836.623985680785, 6914.377706006433, 6934.72261109555, 6946.270641582662, 6979.232284448706, 6822.317768223187, 6926.2034865990045, 6929.376356127922, 6991.230964593941, 7007.229204787469, 6456.935430645681, 6492.772752953624, 6503.512236582275, 6514.44627206688, 6520.347965203489, 7073.080499535027, 7100.68046937889, 7163.42692584592, 7185.0, 7198.5680859148615, 6715.731370745213, 6793.320667933266, 6797.320267973163, 6878.931210687929, 6888.758893438706, 6882.483813713991, 6917.204521479994, 6949.270326615733, 6973.860522789617, 6998.720051197997, 6806.081179040865, 6863.862722745517, 6872.587644741331, 6917.757878474229, 6927.445804335641, 6847.691853866588, 6877.312268773183, 6962.3733863951475, 6966.616836073963, 6988.336108069725, 4974.701517908937, 4980.402351717745, 4983.377077865267, 5011.223260394645, 5080.54275115234, 4573.588377046081, 4645.233536466513, 4646.605038571759, 4649.395578574831, 4677.46209185948, 6366.363363663597, 6406.519511036598, 6442.549021568539, 6458.806235812933, 6462.48300135988, 6814.522983391115, 6879.759208427681, 6889.793306200822, 6898.034275201476, 6967.581945083311, 6386.712597933104, 6392.84017899547, 6432.9385651367, 6440.452561532322, 6463.935360646427, 5518.392976772552, 5548.472895074961, 5598.356189038313, 5612.550995920316, 5620.1288800236025, 7034.718611255595, 7125.180604230476, 7133.357997780225, 7143.7142514299885, 7146.535475194096, 6857.862842743117, 6878.65606719652, 6891.724331026703, 6893.655317234218, 6898.379145876695, 7143.642817858982, 7151.106111736033, 7164.9641751790905, 7167.928320716935, 7290.635468226461, 6827.556208846409, 6849.657517124224, 6916.23921368639, 6933.618650974043, 6953.721851125898, 6945.2707465715375, 6948.444124470131, 7038.683259253244, 7043.401310888632, 7048.154221493453, 6562.573432726857, 6648.268690443951, 6666.966665166643, 6740.39336459721, 6759.898601520883, 6698.330166983263, 6715.395614394728, 6747.392734653905, 6754.2570317266045, 6769.864602708017, 6607.0, 6608.570442921195, 6689.5986240825705, 6694.096297000037, 6702.530822842355, 6703.061571380108, 6711.429528489938, 6712.899306510309, 6734.427573656294, 6818.897716534157, 6462.4183823456115, 6531.150950376421, 6587.440067594308, 6591.736330546724, 6592.110065141144], "value": 6276.270472222339, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [966.2897770138949, 986.6596024371589, 996.7508122969258, 997.6907158780779, 998.0418797953964, 41640.79179604101, 45424.0, 45638.543614563845, 45845.999999999956, 45876.770616146954, 42950.28198872049, 43076.784616076955, 43099.922501937464, 43319.783401082954, 43343.13313733724, 7433.888491672629, 7553.584552849591, 7559.7354092606765, 7562.092548894113, 7567.621618919032, 7401.518901271427, 7428.257174282582, 7496.8125796854965, 7500.624968751541, 7511.0, 7465.701371945116, 7496.850062998737, 7502.662380192877, 7513.699452021912, 8014.398920081017, 8111.391645626572, 8155.10293867674, 8158.347332213409, 8172.795680108015, 8172.918270817305, 7976.880346794803, 8065.6370463329295, 8066.274035336789, 8077.8788318175275, 8081.595920204025, 41134.0, 41948.79025604852, 42337.364939525934, 42428.363574546405, 42620.0, 3714.238581090897, 3747.7938713370754, 3748.5314335708035, 3750.887473375803, 3751.362268414349, 34011.0, 34041.14897127567, 34076.31847363039, 34190.31619367623, 34284.14289642779, 5367.543758780508, 5367.865803354908, 5381.112116500773, 5400.297961265011, 5439.972800135974, 190730.0, 192614.0, 192794.0, 193390.0, 194773.0, 46168.769156154674, 47136.0, 51572.22641660378, 51732.482675173516, 54109.45890541123, 55432.44567554354, 55865.0, 56003.71998139983, 56085.0, 56090.0, 14958.62603434901, 15085.622859428382, 15095.54713358601, 15114.773278400833, 15184.392624295126, 11884.643460696192, 11926.642200733992, 11955.0, 11957.162998590189, 11977.940110299392, 15251.389944402099, 15265.847341526665, 15381.461648842236, 15439.768403473958, 15662.451814186677, 5973.551983601247, 5984.521238301013, 6046.727897244635, 6154.230721159855, 6255.906161407583, 1054.6730513540826, 1071.8767341755797, 1074.6399956014823, 1085.6417382263835, 1092.208149091918, 25646.230613081636, 25807.74192258091, 25857.22428327153, 26033.479330413287, 26060.60909086365, 1160.952499688318, 1168.4099529737427, 1170.414792603698, 1174.512577280436, 1184.6860581945791, 13472.393742281622, 13733.725325493435, 13787.793183102262, 13859.653508662162, 13905.930470347786, 254894.0, 256081.0, 256411.0, 256781.0, 257414.0, 56502.71748641231, 56937.0, 56957.43042569604, 56967.715161424756, 56993.0, 1462.3273294284747, 1468.4346526587128, 1496.4238768074151, 1500.3398504657916, 1516.795232643579, 25114.0, 25184.11855585046, 25316.873415632803, 25630.359241018377, 25704.871475642503, 39934.800325998185, 39954.0, 39972.80013599913, 40007.1998560033, 40069.59930400659, 208871.0, 209064.0, 209150.0, 209393.0, 209960.0, 36817.44773828341, 38118.809405952794, 39007.41488877726, 39118.2176356477, 39126.2174756509, 51174.23238651349, 51758.48241517687, 51818.74090629523, 51829.22256166085, 52096.479035209166, 37175.81412092922, 37766.622333777406, 37887.242255155295, 38024.0, 38038.0, 36622.0, 36630.267394651426, 36911.0, 36956.260874781816, 37503.624963750015, 43619.345709813744, 43681.78159109184, 43887.34168987404, 43946.34080488731, 44204.77897610491, 35037.47443788396, 35129.64870351264, 35381.82309088438, 35731.285374291845, 35750.4637430444, 26713.33216669599, 26972.460550789267, 27079.916803328433, 27168.320791980357, 27457.86271068632], "value": 18404.520284918766, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [590.0, 602.0487629545318, 609.3297372889824, 611.3092205807437, 625.3933684326204, 23103.306900792963, 23893.522129557397, 23910.163144289952, 23921.641175382385, 24018.999999999978, 22557.774422255774, 24588.0, 24619.63070553943, 24661.013559457646, 25014.87492562539, 6675.699593518303, 6829.521933464659, 6835.248122706498, 6838.760643377483, 6842.55523390978, 6477.54657173998, 6739.831504212385, 6748.156480439945, 6756.932430675704, 6760.459163266952, 6658.600483970978, 6713.597184168965, 6718.865622687544, 6733.360330768569, 6733.8989915151315, 6388.265349484822, 6667.533272670915, 6669.733210671568, 6689.498287628423, 6742.730290788362, 6209.658468784215, 6228.719707613123, 6230.87538249237, 6231.532635052344, 6232.937670623326, 29608.703912961024, 30108.24729381783, 30110.698893011227, 30119.0, 30123.548146777815, 2237.3847192022163, 2265.3543740034174, 2265.716785401825, 2266.2634643740685, 2266.580682573729, 19701.0, 21098.261560845298, 21138.471538211514, 21141.577168456697, 21167.153313867428, 2496.1513085551, 2526.090607381341, 2563.9359016024564, 2564.294818924792, 2564.6922369315803, 126891.0, 133183.0, 141983.0, 149716.0, 149747.0, 15292.082475051533, 15314.770278445832, 15350.616234594001, 15802.024746906636, 15808.865803116432, 24331.878340608182, 24374.26877193687, 24382.512349752906, 24389.390265243157, 24390.26829195127, 9911.603535858485, 9915.405075695482, 9953.751156221153, 9979.800403992025, 10037.0, 8943.508107054175, 8978.910210897808, 9025.50359730208, 9034.774130646787, 9093.4998575079, 9302.302327325342, 9652.324337296463, 9678.75803104914, 9712.5143742814, 9761.07269809367, 2880.481513327621, 2926.4878646236825, 2945.1017439681104, 2971.242333205019, 3058.2965917839024, 1019.2712210769336, 1031.85038169465, 1040.8646875906236, 1042.2756184451885, 1043.4886905416292, 20583.485412864797, 20814.0, 20939.58120837575, 20983.55754857997, 20984.467599642485, 1032.3444612671008, 1059.2849826367171, 1073.1361254190297, 1080.1358912869673, 1086.1419478611965, 11674.241174323643, 11680.123990700731, 11695.707607309716, 11696.532138714527, 11851.585194518151, 519374.0, 529024.0, 549481.0, 559617.0, 563366.0, 121938.0, 124555.0, 126084.36957815153, 127693.0, 128818.35590821986, 1175.6590588729173, 1183.4437814227472, 1201.591458903977, 1209.2079687804503, 1213.1932265043647, 18878.622427551647, 19103.61792764109, 19188.424347269603, 19413.0, 19629.11668974871, 58809.4119058821, 58850.411495886205, 60001.0, 60045.0, 61384.386156139655, 77384.61307693426, 77387.61306193433, 77432.61283693546, 77777.0, 78584.60707696425, 15447.691046179238, 15676.372945082068, 15756.684866302381, 15763.369465221722, 15794.526164215093, 23912.163074292315, 23947.281581552583, 23956.88021559881, 24197.395065123514, 24292.78536073154, 18028.188731507376, 18308.542286442946, 19681.704774428108, 20013.199472020955, 20024.39926802198, 17332.740008899626, 17440.47678569645, 17685.204165812826, 17771.378001769877, 17958.102094895465, 18484.16821243074, 18621.627567448846, 18787.812121879153, 18811.341603043827, 20093.6985945208, 15217.543473695807, 15361.923190383977, 15369.0, 15374.077555346268, 15374.461893833663, 19492.0, 19497.0, 19686.90156549208, 19846.305379311656, 19857.404277871687], "value": 12506.572238898241, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1436.0737324425745, 1483.4807817263966, 1485.8365579786227, 1488.0922637191318, 1494.7384207763641, 16616.418425355114, 17237.569060773487, 17251.0, 17323.566910827234, 17348.21933013014, 16889.071101089434, 16914.0, 17011.149442527887, 17013.064281464514, 17053.232604532794, 2762.7513523782854, 2817.0281252967798, 2817.8591070446496, 2819.6898341182455, 2820.746132848043, 2737.5893615957666, 2817.7323154300307, 2820.562812764025, 2828.010196431253, 2835.6455443069617, 2642.960355594658, 2857.157138644105, 2857.385662082652, 2857.6570811502647, 2858.0568412423954, 2839.6734375546766, 2845.644294463192, 2855.1434569629027, 2857.0857325655797, 2877.4101309231555, 2808.7191280871953, 2813.9859300703365, 2817.788665850049, 2820.562812764025, 2826.5194916864184, 16490.917545412198, 16877.324907003705, 16888.662226755398, 16892.408765693264, 16903.83096169035, 7851.528908265465, 8070.596470176468, 8118.594070296521, 8130.390220733469, 8132.308753755938, 5418.7019713915715, 5563.610547261694, 5658.603897727161, 5714.542836573064, 5759.308882934075, 2051.292304155064, 2104.2109209046607, 2105.9473513162293, 2131.4032071020138, 2152.967705484419, 30533.694663053306, 30635.387292254254, 30696.53955190674, 30756.0, 30941.535876962087, 6897.448204143657, 6980.581165130007, 7000.124984376953, 7011.0, 7011.509194356346, 19431.902840485705, 19703.704444433344, 19708.113134908963, 19719.211231550576, 19734.30929917446, 8104.27061564462, 8118.797030074295, 8148.714794982147, 8175.754727358189, 8176.3867709922, 7362.705491780376, 7432.665530051161, 7456.7762967111075, 7467.626618669045, 7509.324160825552, 5545.639533430314, 5805.303363596396, 5822.417758224144, 5841.970790146107, 5885.0, 1542.6066353079893, 1545.3895711194016, 1579.676166385888, 1591.9204039797964, 1621.7243068678354, 924.5284904698652, 933.486582379702, 940.031767279703, 947.696737044153, 953.0993211415284, 9043.59303831329, 9049.457032578066, 9070.410423322463, 9151.17639412456, 9283.535823208813, 1025.876894772632, 1028.7376718936773, 1037.7042542875245, 1041.3127335958231, 1053.0943388685878, 4735.360726301905, 4773.164696178155, 5036.0, 5235.476452354734, 5250.606204534675, 25308.114216002352, 25924.481510369686, 25988.74011259901, 26147.869260653955, 26220.344491387867, 24185.51628967411, 25565.23304300874, 25744.742552574608, 25929.74070259273, 25980.090696825897, 11646.359450230319, 12047.457864396123, 12281.631551053482, 12296.569620063256, 12362.320072395925, 9367.0, 9412.623495060121, 9549.665761698307, 9623.759406014906, 9625.470599117116, 21004.0, 21075.26236581712, 21124.788752112898, 21681.78318216861, 22022.11911523521, 21910.561788764455, 21976.34070977873, 22061.0, 22111.44721381978, 22244.221452249094, 13269.734605307647, 13604.65988350299, 13715.177089374669, 13715.862841371458, 13724.039317247696, 14785.334659940543, 14917.925410372878, 14970.17664028489, 14989.475368362055, 15003.549893502775, 11370.829437558277, 11932.701682458008, 12493.18794278369, 12578.0, 12627.558035468715, 11959.282443053444, 11976.16166868311, 12220.755584888075, 12231.69420764488, 12300.0, 11080.556777729123, 11144.665660030212, 11207.439628018403, 11253.66239012831, 11273.605423810128, 7776.494527855672, 7896.0, 7940.960295198487, 8041.798955026171, 8122.593870306343, 7975.80060498469, 8013.0, 8022.237887400687, 8054.637541310538, 8209.958950205211], "value": 7262.000155318944, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [527.6939375162403, 553.463140753469, 564.7119968815903, 564.7966731976488, 566.7477972302324, 6220.875582488347, 6295.590786598874, 6309.652969086698, 6318.810435686931, 6330.588511746739, 6199.504039676826, 6216.627002379849, 6259.405356491137, 6307.62154270744, 6322.336154703758, 5114.693118412898, 5121.180611102224, 5136.794528218867, 5159.251908473288, 5161.458046905059, 4831.613470922335, 5086.135356989321, 5125.2312153176945, 5125.461826508219, 5146.047981123485, 4879.707217566957, 4908.926366104493, 4917.40991081069, 4931.334269873557, 4973.328600638922, 4892.192788189962, 4913.803447862081, 4916.58209052231, 4937.037277730844, 4960.578350840183, 4332.133573285356, 4449.866504004885, 4484.461864576272, 4486.8878278042985, 4487.910241795146, 6015.789447369321, 6060.484858787008, 6066.96966515169, 6131.417515336036, 6137.478314343286, 5802.680852553108, 5847.678377689225, 5851.712623222884, 5865.912011319833, 5887.411258874121, 6624.7412991531455, 6656.36764507371, 6677.666116694194, 6731.158605174353, 6733.653269346101, 5035.899282014376, 5039.0, 5042.924356134661, 5056.494350564951, 5079.720615366154, 6777.457803375718, 6820.761273355409, 6868.656567171622, 6926.757563485254, 6981.5461994970165, 5112.667676601009, 5142.61430392722, 5206.7564934578195, 5211.212001579137, 5219.0, 5212.478752124757, 5261.105612045962, 5286.497782710637, 5291.735413229323, 5301.390340110859, 5768.7692492300675, 5771.192033115367, 5814.360420353758, 5844.6785426801935, 5848.777464563439, 6634.900476492857, 6720.831979200461, 6732.831679208059, 6742.584057348012, 6767.966160169168, 1799.1543974332044, 1808.538822600255, 1818.8908665480114, 1825.4797382745853, 1838.4576549917806, 1239.5599562155485, 1240.2670734848434, 1258.2199036597185, 1288.2978776566792, 1291.7674818532566, 6228.377162283736, 6229.595076320024, 6248.0, 6274.341194174637, 6287.0, 6686.531942764057, 6804.217514985741, 6814.829629259309, 6837.974303854362, 6859.878755166387, 6009.909851352233, 6112.8777424452155, 6148.661823599745, 6239.438450539383, 6282.685865706788, 3506.561679790026, 3547.7161827053774, 3552.484889691032, 3569.785812851237, 3585.8924232273075, 6888.311168883171, 6920.757773477904, 6927.688254028581, 7015.964920175366, 7033.4724895633035, 6878.621675807879, 6930.965345173242, 6958.130233720785, 6972.442204623618, 6989.231184569693, 7082.610456424843, 7090.042844216068, 7099.2545782693105, 7101.893471598033, 7106.857862842714, 6811.182658081062, 6826.658667066726, 6839.487038472234, 6868.347506986828, 6875.3812156906115, 6751.7171737369745, 6791.830204244736, 6815.488838337244, 6823.0, 6836.589804611739, 7023.331134168983, 7025.613591252531, 7090.255523170199, 7147.392471639969, 7147.821304467222, 5198.142306519533, 5206.349206349207, 5214.530692237717, 5234.502722241381, 5239.580833533232, 6545.8690826184165, 6673.731990921709, 6747.527673063035, 6785.185777706707, 6851.143607049119, 6473.287938326686, 6562.981028726648, 6589.0116482528, 6602.471802255904, 6604.570702904488, 6504.60972341661, 6514.51141164424, 6558.508111891531, 6593.208814942238, 6619.172603424572, 6452.870942581216, 6464.41820236181, 6536.967315163393, 6538.280789113289, 6580.802575922538, 6580.144581204413, 6636.767713130017, 6644.335566443317, 6646.60120392778, 6670.866582668416, 6400.71196796136, 6401.303654531646, 6458.451031662361, 6479.352064793483, 6494.545381823227], "value": 5188.485259846145, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [988.9851652225213, 989.3272574649238, 1004.0963133180137, 1009.8283291840387, 1012.2610494339137, 18874.43376698698, 19398.903005484954, 19399.418017459462, 19421.0, 19431.41705748828, 16104.919475402636, 16106.114163720991, 16132.435364762236, 16155.0, 16156.75764863528, 1043.572135424476, 1075.2903083964584, 1075.4085253110798, 1077.466654006268, 1078.062085985192, 1094.9980767597638, 1097.0729733375285, 1097.6322931817851, 1097.736543229623, 1098.1379617000657, 1067.770429357688, 1106.065374758332, 1110.639042311248, 1117.7876203521346, 1120.512577028991, 1108.8558487396626, 1113.3653817324127, 1113.6603335982522, 1113.9944300278487, 1114.9275297105703, 796.665400531778, 813.589137485566, 816.9101398846122, 818.8689809630431, 831.6257684042205, 21052.368428947157, 21296.361109166595, 21305.786942130537, 21366.679499807517, 21382.67925981096, 22694.659580106312, 22817.543649126925, 23086.307410777703, 23328.533429331317, 23341.53316933669, 17629.206685699173, 17665.38171164003, 17694.646107077915, 17772.200250988735, 17873.463796086136, 3969.364901615728, 3997.1006523532265, 3999.0202400412086, 4001.339778936472, 4002.3596224603925, 125145.0, 157688.0, 158254.0, 159513.0, 160701.0, 18017.819821801615, 18568.0, 18668.253269869052, 18685.532861678294, 18765.155567999474, 33641.49537756936, 33748.66251337504, 33899.0, 34473.13817154541, 34482.310353793284, 10221.080102790784, 10294.124999374988, 10319.74200644975, 10428.739281518023, 10448.111910487542, 4653.674242803039, 4693.084848454587, 4738.19450693383, 4743.857684269477, 4758.976205118952, 5933.0, 6037.094435834572, 6043.909341359883, 6060.363661815534, 6081.118237855486, 1282.538286216961, 1296.1056870759335, 1308.8363954505687, 1312.4225340849996, 1319.2546211390534, 735.6946867050115, 741.3105811595268, 748.098541257783, 756.9053868266467, 763.694522191128, 13240.470381184645, 13412.664683382798, 13603.047786655037, 14001.089929154572, 14026.158430494203, 741.1328745367932, 750.1748077115129, 751.4589495563185, 755.7704770925791, 762.954222746637, 5838.766449341979, 5859.589828712034, 5867.794627188028, 5997.340292567814, 6066.363031881677, 147961.0, 150111.0, 151064.0, 151284.48715512923, 151824.0, 100626.0, 127175.36412317879, 134400.0, 137829.0, 138010.0, 111083.44458277657, 111830.0, 112113.0, 112329.87670123357, 114261.0, 14654.340554675278, 14895.851041489446, 14931.776023359875, 15064.924675376553, 15078.849211507744, 53401.46598533965, 53979.0, 54643.18035229395, 56027.71986140043, 56160.43839561552, 71598.0, 71807.64096179485, 72511.0, 72868.27131728615, 73011.63494182494, 18693.158807853408, 18770.6245875079, 18842.811571884107, 18871.0, 19028.143733532303, 22877.542449151257, 23049.617022978004, 23218.65172022455, 23480.295591132293, 23505.412364690335, 20811.8959405202, 21270.680939785605, 21308.680369794154, 21415.357539273846, 21606.2437814682, 19748.90125549363, 19829.504262393555, 19842.0, 19875.503112422306, 19892.60214795725, 18903.621927561646, 18909.149088290786, 18961.525961851064, 19167.32914348047, 19198.71201932, 14381.42474301058, 14496.275186240435, 14791.852081479048, 14878.10731356122, 14892.7766083511, 14674.70650586961, 14840.10959342443, 15068.472603458826, 15072.849271507583, 15093.0], "value": 10212.141110010443, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1392.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 105.0, 105.0, 105.0, 105.0, 115.0, 105.0, 105.0, 104.0, 112.0], "value": 106.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 114.0, 114.0, 116.0, 115.0, 114.0, 115.0, 113.0, 113.0, 112.0], "value": 114.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 164.0, 162.0, 164.0, 162.0, 161.0, 162.0, 165.0, 164.0], "value": 162.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 74.0, 74.0, 73.0, 73.0, 73.0, 73.0, 72.0, 74.0], "value": 73.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 79.0, 80.0, 77.0, 77.0, 77.0, 81.0, 81.0, 79.0, 83.0], "value": 80.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 114.0, 113.0, 110.0, 113.0, 114.0, 113.0, 115.0, 113.0], "value": 113.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 151.0, 150.0, 150.0, 149.0, 149.0, 148.0, 148.0, 150.0], "value": 149.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 94.0, 94.0, 93.0, 94.0, 94.0, 96.0, 94.0, 95.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [47.0, 44.0, 47.0, 46.0, 45.0, 45.0, 44.0, 43.0, 47.0, 43.0], "value": 45.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 47.0, 47.0, 49.0, 48.0, 47.0, 47.0, 48.0, 48.0], "value": 48.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 72.0, 72.0, 76.0, 77.0, 73.0, 71.0, 71.0, 71.0], "value": 73.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 109.0, 133.0, 118.0, 109.0, 113.0, 117.0, 111.0, 119.0, 116.0], "value": 115.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 160.0, 152.0, 153.0, 155.0, 163.0, 149.0, 161.0, 150.0, 151.0], "value": 156.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 58.0, 60.0, 61.0, 60.0, 59.0, 58.0, 61.0, 58.0, 58.0], "value": 59.2, "unit": "score"}]}]} 11:55:46 INFO - Return code: 0 11:55:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:55:46 INFO - # TBPL SUCCESS # 11:55:46 INFO - Running post-action listener: _package_coverage_data 11:55:46 INFO - Running post-action listener: _resource_record_post_action 11:55:46 INFO - [mozharness: 2017-09-10 18:55:46.469186Z] Finished run-tests step (success) 11:55:46 INFO - Running post-run listener: _resource_record_post_run 11:55:46 INFO - Total resource usage - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 290099200; Read time: 0; Write time: 143808 11:55:46 INFO - TinderboxPrint: CPU usage
13.1% 11:55:46 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 11:55:46 INFO - TinderboxPrint: I/O write bytes / time
290,099,200 / 143,808 11:55:46 INFO - TinderboxPrint: CPU idle
8,191.4 (86.9%) 11:55:46 INFO - TinderboxPrint: CPU user
1,184.8 (12.6%) 11:55:46 INFO - TinderboxPrint: Swap in / out
0 / 0 11:55:46 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 12410880; Read time: 0; Write time: 2108 11:55:46 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:55:46 INFO - run-tests - Wall time: 1166s; CPU: 13.0%; Read bytes: 0; Write bytes: 277688320; Read time: 0; Write time: 141700 11:55:47 INFO - Running post-run listener: _upload_blobber_files 11:55:47 INFO - Blob upload gear active. 11:55:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:55:47 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:55:47 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:55:47 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:55:47 INFO - (blobuploader) - INFO - Open directory for files ... 11:55:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:55:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:55:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:55:48 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:55:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:55:48 INFO - (blobuploader) - INFO - Done attempting. 11:55:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:55:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:55:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:55:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:55:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:55:49 INFO - (blobuploader) - INFO - Done attempting. 11:55:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:55:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:55:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:55:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:55:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:55:56 INFO - (blobuploader) - INFO - Done attempting. 11:55:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:55:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:55:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:55:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:55:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:55:57 INFO - (blobuploader) - INFO - Done attempting. 11:55:57 INFO - (blobuploader) - INFO - Iteration through files over. 11:55:57 INFO - Return code: 0 11:55:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:55:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:55:57 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4577fa55429b1f565bea4ce11eff53558993c529e2ef6a1f7c0fa5a0b6c98f4ad743db063b092453b91a440883138b719f83a6bae5fd5f3cf137082d5a510f38", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4fa5f2d7d4c9e6be4046e89fb5a0b09adc8d3ceb386098cfe2a31293d9f68d8361888cef3ff6d0ddf8566e5eca17d00935f5f10d0a19ba83e897453d65fb9887", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c74f3119c42b8e40a9fd730690c32af98178d5915925ad38d8e4e7baa35dd0972698447c4b3ebfef190a6e546395124fcaf7bc0e13339ce5a5b0b057c2bf35df", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/30e1675dd37b0a005761ec335be51cff8528e6cf053a68e3f85bdcc7cd8fb1e4e7932ef37c8491012602fa2b01e5d2b50a8704760536540a833d6481a2c70cdf"} 11:55:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:55:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:55:57 INFO - Contents: 11:55:57 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4577fa55429b1f565bea4ce11eff53558993c529e2ef6a1f7c0fa5a0b6c98f4ad743db063b092453b91a440883138b719f83a6bae5fd5f3cf137082d5a510f38", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4fa5f2d7d4c9e6be4046e89fb5a0b09adc8d3ceb386098cfe2a31293d9f68d8361888cef3ff6d0ddf8566e5eca17d00935f5f10d0a19ba83e897453d65fb9887", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c74f3119c42b8e40a9fd730690c32af98178d5915925ad38d8e4e7baa35dd0972698447c4b3ebfef190a6e546395124fcaf7bc0e13339ce5a5b0b057c2bf35df", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/30e1675dd37b0a005761ec335be51cff8528e6cf053a68e3f85bdcc7cd8fb1e4e7932ef37c8491012602fa2b01e5d2b50a8704760536540a833d6481a2c70cdf"} 11:55:57 INFO - Running post-run listener: copy_logs_to_upload_dir 11:55:57 INFO - Copying logs to upload dir... 11:55:57 INFO - mkdir: /builds/slave/test/build/upload/logs 11:55:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.692042 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2017-09-10 11:55:57.744013) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-10 11:55:57.747924) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1505067859.53232-898075472 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/4577fa55429b1f565bea4ce11eff53558993c529e2ef6a1f7c0fa5a0b6c98f4ad743db063b092453b91a440883138b719f83a6bae5fd5f3cf137082d5a510f38", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4fa5f2d7d4c9e6be4046e89fb5a0b09adc8d3ceb386098cfe2a31293d9f68d8361888cef3ff6d0ddf8566e5eca17d00935f5f10d0a19ba83e897453d65fb9887", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c74f3119c42b8e40a9fd730690c32af98178d5915925ad38d8e4e7baa35dd0972698447c4b3ebfef190a6e546395124fcaf7bc0e13339ce5a5b0b057c2bf35df", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/30e1675dd37b0a005761ec335be51cff8528e6cf053a68e3f85bdcc7cd8fb1e4e7932ef37c8491012602fa2b01e5d2b50a8704760536540a833d6481a2c70cdf"} build_url:https://queue.taskcluster.net/v1/task/LDhY0lhSTCW5nAVURJ1tfA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011436 build_url: 'https://queue.taskcluster.net/v1/task/LDhY0lhSTCW5nAVURJ1tfA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4577fa55429b1f565bea4ce11eff53558993c529e2ef6a1f7c0fa5a0b6c98f4ad743db063b092453b91a440883138b719f83a6bae5fd5f3cf137082d5a510f38", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4fa5f2d7d4c9e6be4046e89fb5a0b09adc8d3ceb386098cfe2a31293d9f68d8361888cef3ff6d0ddf8566e5eca17d00935f5f10d0a19ba83e897453d65fb9887", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c74f3119c42b8e40a9fd730690c32af98178d5915925ad38d8e4e7baa35dd0972698447c4b3ebfef190a6e546395124fcaf7bc0e13339ce5a5b0b057c2bf35df", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/30e1675dd37b0a005761ec335be51cff8528e6cf053a68e3f85bdcc7cd8fb1e4e7932ef37c8491012602fa2b01e5d2b50a8704760536540a833d6481a2c70cdf"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-10 11:55:57.776527) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-10 11:55:57.776867) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1505067859.53232-898075472 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004570 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-10 11:55:57.862687) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-10 11:55:57.863043) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-10 11:55:57.863359) ========= ========= Total master_lag: 0.21 =========