builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-058 starttime: 1504807423.94 results: success (0) revision: 3c96d611ebd67fc219d22bcb476a72412c76f6c7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-07 11:03:43.940333) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-07 11:03:43.940841) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-07 11:03:43.941155) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-07 11:03:43.958756) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 11:03:43.959135) ========= 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=0e2a256762fed810e2f0f810000001b3-1504807422.634008-1470331620 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-07 11:03:44-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 41.8M=0s 2017-09-07 11:03:44 (41.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.169946 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 11:03:44.166115) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 11:03:44.166492) ========= 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=0e2a256762fed810e2f0f810000001b3-1504807422.634008-1470331620 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020179 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 11:03:44.215928) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 11:03:44.216310) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3c96d611ebd67fc219d22bcb476a72412c76f6c7 --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 3c96d611ebd67fc219d22bcb476a72412c76f6c7 --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=0e2a256762fed810e2f0f810000001b3-1504807422.634008-1470331620 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-07 11:03:44,273 truncating revision to first 12 chars 2017-09-07 11:03:44,273 Setting DEBUG logging. 2017-09-07 11:03:44,274 attempt 1/10 2017-09-07 11:03:44,274 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3c96d611ebd6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-07 11:03:44,656 unpacking tar archive at: mozilla-central-3c96d611ebd6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.655901 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 11:03:44.889292) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-07 11:03:44.889685) ========= script_repo_revision: 3c96d611ebd67fc219d22bcb476a72412c76f6c7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-07 11:03:44.890131) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-07 11:03:44.890430) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-07 11:03:44.903095) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-09-07 11:03:44.903425) ========= /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=0e2a256762fed810e2f0f810000001b3-1504807422.634008-1470331620 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:03:45 INFO - MultiFileLogger online at 20170907 11:03:45 in /builds/slave/test 11:03:45 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:03:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:03:45 INFO - {'append_to_log': False, 11:03:45 INFO - 'base_work_dir': '/builds/slave/test', 11:03:45 INFO - 'blob_upload_branch': 'Firefox', 11:03:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:03:45 INFO - 'branch': 'Firefox', 11:03:45 INFO - 'buildbot_json_path': 'buildprops.json', 11:03:45 INFO - 'code_coverage': False, 11:03:45 INFO - 'config_files': ('talos/linux_config.py',), 11:03:45 INFO - 'default_actions': ('clobber', 11:03:45 INFO - 'read-buildbot-config', 11:03:45 INFO - 'download-and-extract', 11:03:45 INFO - 'populate-webroot', 11:03:45 INFO - 'create-virtualenv', 11:03:45 INFO - 'install', 11:03:45 INFO - 'setup-mitmproxy', 11:03:45 INFO - 'run-tests'), 11:03:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:03:45 INFO - 'disable_ccov_upload': False, 11:03:45 INFO - 'disable_stylo': False, 11:03:45 INFO - 'download_minidump_stackwalk': True, 11:03:45 INFO - 'download_symbols': 'ondemand', 11:03:45 INFO - 'enable_stylo': False, 11:03:45 INFO - 'enable_webrender': False, 11:03:45 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 11:03:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:03:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:03:45 INFO - 'gecko_profile': False, 11:03:45 INFO - 'gecko_profile_interval': 0, 11:03:45 INFO - 'installer_path': 'installer.exe', 11:03:45 INFO - 'log_level': 'info', 11:03:45 INFO - 'log_name': 'talos', 11:03:45 INFO - 'log_to_console': True, 11:03:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:03:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:03:45 INFO - 'opt_config_files': (), 11:03:45 INFO - 'pip_index': False, 11:03:45 INFO - 'suite': 'dromaeojs-e10s', 11:03:45 INFO - 'system_bits': '32', 11:03:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:03:45 INFO - 'title': 'talos-linux64-ix-058', 11:03:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:03:45 INFO - 'use_talos_json': True, 11:03:45 INFO - 'verify': 'False', 11:03:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:03:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:03:45 INFO - 'work_dir': 'build'} 11:03:45 INFO - [mozharness: 2017-09-07 18:03:45.275618Z] Running clobber step. 11:03:45 INFO - Running pre-action listener: _resource_record_pre_action 11:03:45 INFO - Running main action method: clobber 11:03:45 INFO - rmtree: /builds/slave/test/build 11:03:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:03:46 INFO - Running post-action listener: _resource_record_post_action 11:03:46 INFO - [mozharness: 2017-09-07 18:03:46.270341Z] Finished clobber step (success) 11:03:46 INFO - [mozharness: 2017-09-07 18:03:46.270449Z] Running read-buildbot-config step. 11:03:46 INFO - Running pre-action listener: _resource_record_pre_action 11:03:46 INFO - Running main action method: read_buildbot_config 11:03:46 INFO - Using buildbot properties: 11:03:46 INFO - { 11:03:46 INFO - "project": "", 11:03:46 INFO - "product": "firefox", 11:03:46 INFO - "who": "ffxbld@noreply.mozilla.org", 11:03:46 INFO - "installer_path": "public/build/target.tar.bz2", 11:03:46 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 11:03:46 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:03:46 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 11:03:46 INFO - "stage_platform": "linux64-qr", 11:03:46 INFO - "basedir": "/builds/slave/test", 11:03:46 INFO - "buildnumber": 35, 11:03:46 INFO - "platform": "ubuntu64_hw_qr", 11:03:46 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:03:46 INFO - "slavebuilddir": "test", 11:03:46 INFO - "taskId": "UqiLMsfFRbC7ewEz9b3vpw", 11:03:46 INFO - "branch": "mozilla-central", 11:03:46 INFO - "script_repo_revision": "production", 11:03:46 INFO - "revision": "3c96d611ebd67fc219d22bcb476a72412c76f6c7", 11:03:46 INFO - "slavename": "talos-linux64-ix-058", 11:03:46 INFO - "repo_path": "mozilla-central" 11:03:46 INFO - } 11:03:46 INFO - Finding installer, test and symbols from parent task. 11:03:46 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UqiLMsfFRbC7ewEz9b3vpw'}, attempt #1 11:03:46 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UqiLMsfFRbC7ewEz9b3vpw'}, attempt #1 11:03:47 INFO - Task dependencies: ErCwGB7lSTS6L7N4qpQiKw 11:03:47 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw'}, attempt #1 11:03:47 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.tar.bz2 11:03:47 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.test_packages.json 11:03:47 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.crashreporter-symbols.zip 11:03:47 INFO - Running post-action listener: _resource_record_post_action 11:03:47 INFO - [mozharness: 2017-09-07 18:03:47.666220Z] Finished read-buildbot-config step (success) 11:03:47 INFO - [mozharness: 2017-09-07 18:03:47.666459Z] Running download-and-extract step. 11:03:47 INFO - Running pre-action listener: _resource_record_pre_action 11:03:47 INFO - Running main action method: download_and_extract 11:03:47 INFO - mkdir: /builds/slave/test/build/tests 11:03:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:03:47 INFO - trying https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.test_packages.json 11:03:47 INFO - Downloading https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:03:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:03:48 INFO - Downloaded 989 bytes. 11:03:48 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:03:48 INFO - Using the following test package requirements: 11:03:48 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:03:48 INFO - u'common': [u'target.common.tests.zip'], 11:03:48 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:03:48 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:03:48 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:03:48 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:03:48 INFO - u'mozbase': [u'target.common.tests.zip'], 11:03:48 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:03:48 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:03:48 INFO - u'web-platform': [u'target.common.tests.zip', 11:03:48 INFO - u'target.web-platform.tests.tar.gz'], 11:03:48 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:03:48 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 11:03:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.common.tests.zip 11:03:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:03:48 INFO - Fetch https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.common.tests.zip into memory 11:03:49 INFO - Content-Length response header: 55021210 11:03:49 INFO - Bytes received: 55021210 11:04:00 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 11:04:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.common.tests.zip 11:04:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:04:00 INFO - Fetch https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.common.tests.zip into memory 11:04:01 INFO - Content-Length response header: 55021210 11:04:01 INFO - Bytes received: 55021210 11:04:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.talos.tests.zip 11:04:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:04:13 INFO - Fetch https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.talos.tests.zip into memory 11:04:14 INFO - Content-Length response header: 14496665 11:04:14 INFO - Bytes received: 14496665 11:04:15 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:04:15 INFO - trying https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.tar.bz2 11:04:15 INFO - Downloading https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:04:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:04:16 INFO - Downloaded 62754681 bytes. 11:04:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.tar.bz2 11:04:16 INFO - mkdir: /builds/slave/test/properties 11:04:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:04:16 INFO - Writing to file /builds/slave/test/properties/build_url 11:04:16 INFO - Contents: 11:04:16 INFO - build_url:https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.tar.bz2 11:04:16 INFO - Running post-action listener: _resource_record_post_action 11:04:16 INFO - Running post-action listener: find_tests_for_verification 11:04:16 INFO - Running post-action listener: set_extra_try_arguments 11:04:16 INFO - [mozharness: 2017-09-07 18:04:16.326214Z] Finished download-and-extract step (success) 11:04:16 INFO - [mozharness: 2017-09-07 18:04:16.326313Z] Running populate-webroot step. 11:04:16 INFO - Running pre-action listener: _resource_record_pre_action 11:04:16 INFO - Running main action method: populate_webroot 11:04:16 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:04:16 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:04:16 INFO - 'tests': ['tresize', 11:04:16 INFO - 'tcanvasmark']}, 11:04:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:04:16 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:04:16 INFO - 'tests': ['dromaeo_css', 11:04:16 INFO - 'kraken']}, 11:04:16 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:04:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:04:16 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:04:16 INFO - 'talos_options': ['--disable-stylo'], 11:04:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:04:16 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:04:16 INFO - 'tests': ['damp', 'tps']}, 11:04:16 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:04:16 INFO - 'talos_options': ['--disable-stylo'], 11:04:16 INFO - 'tests': ['damp', 'tps']}, 11:04:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:04:16 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:04:16 INFO - 'tests': ['dromaeo_dom']}, 11:04:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:04:16 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:04:16 INFO - 'tests': ['basic_compositor_video', 11:04:16 INFO - 'glvideo']}, 11:04:16 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:04:16 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:04:16 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:04:16 INFO - 'talos_options': ['--disable-stylo'], 11:04:16 INFO - 'tests': ['ts_paint_webext', 11:04:16 INFO - 'tp5o_webext']}, 11:04:16 INFO - 'other-e10s': {'tests': ['a11yr', 11:04:16 INFO - 'ts_paint', 11:04:16 INFO - 'tpaint', 11:04:16 INFO - 'sessionrestore', 11:04:16 INFO - 'sessionrestore_many_windows', 11:04:16 INFO - 'sessionrestore_no_auto_restore', 11:04:16 INFO - 'tabpaint']}, 11:04:16 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:04:16 INFO - 'tests': ['a11yr', 11:04:16 INFO - 'ts_paint', 11:04:16 INFO - 'tpaint', 11:04:16 INFO - 'sessionrestore', 11:04:16 INFO - 'sessionrestore_many_windows', 11:04:16 INFO - 'sessionrestore_no_auto_restore', 11:04:16 INFO - 'tabpaint']}, 11:04:16 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 11:04:16 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 11:04:16 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:04:16 INFO - 'tests': ['bloom_basic_singleton']}, 11:04:16 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:04:16 INFO - 'tests': ['bloom_basic']}, 11:04:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:04:16 INFO - 'tsvgr_opacity', 11:04:16 INFO - 'tart', 11:04:16 INFO - 'tscrollx', 11:04:16 INFO - 'tsvg_static']}, 11:04:16 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:04:16 INFO - 'tests': ['tsvgx', 11:04:16 INFO - 'tsvgr_opacity', 11:04:16 INFO - 'tart', 11:04:16 INFO - 'tscrollx', 11:04:16 INFO - 'tsvg_static']}, 11:04:16 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:04:16 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:04:16 INFO - 'talos_options': ['--disable-stylo'], 11:04:16 INFO - 'tests': ['tp5o']}, 11:04:16 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:04:16 INFO - 'talos_options': ['--mitmproxy', 11:04:16 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:04:16 INFO - '--firstNonBlankPaint'], 11:04:16 INFO - 'tests': ['tp6_google', 11:04:16 INFO - 'tp6_youtube', 11:04:16 INFO - 'tp6_amazon', 11:04:16 INFO - 'tp6_facebook']}, 11:04:16 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:04:16 INFO - 'talos_options': ['--disable-stylo', 11:04:16 INFO - '--mitmproxy', 11:04:16 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:04:16 INFO - '--firstNonBlankPaint'], 11:04:16 INFO - 'tests': ['tp6_google', 11:04:16 INFO - 'tp6_youtube', 11:04:16 INFO - 'tp6_amazon', 11:04:16 INFO - 'tp6_facebook']}, 11:04:16 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:04:16 INFO - 'talos_options': ['--stylo-threads=1', 11:04:16 INFO - '--mitmproxy', 11:04:16 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:04:16 INFO - '--firstNonBlankPaint'], 11:04:16 INFO - 'tests': ['tp6_google', 11:04:16 INFO - 'tp6_youtube', 11:04:16 INFO - 'tp6_amazon', 11:04:16 INFO - 'tp6_facebook']}, 11:04:16 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:04:16 INFO - 'talos_options': ['--xperf_path', 11:04:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:04:16 INFO - 'tests': ['tp5n']}, 11:04:16 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:04:16 INFO - 'talos_options': ['--disable-stylo', 11:04:16 INFO - '--xperf_path', 11:04:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:04:16 INFO - 'tests': ['tp5n']}}} 11:04:16 INFO - Running post-action listener: _resource_record_post_action 11:04:16 INFO - [mozharness: 2017-09-07 18:04:16.341300Z] Finished populate-webroot step (success) 11:04:16 INFO - [mozharness: 2017-09-07 18:04:16.341390Z] Running create-virtualenv step. 11:04:16 INFO - Running pre-action listener: _resource_record_pre_action 11:04:16 INFO - Running main action method: create_virtualenv 11:04:16 INFO - Creating virtualenv /builds/slave/test/build/venv 11:04:16 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:04:16 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 11:04:16 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:04:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:04:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:04:18 INFO - Installing distribute.............................................................................................................................................................................................done. 11:04:18 INFO - Installing pip...............done. 11:04:18 INFO - Return code: 0 11:04:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:04:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:04:18 INFO - Reading from file tmpfile_stdout 11:04:18 INFO - Output received: 11:04:18 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:04:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:04:18 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:04:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:04:18 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:04:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:04:18 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 0x19131f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c7fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c83090>, '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 0x1c83d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c7df90>, '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': '0e2a256762fed810e2f0f810000001b3-1504807422.634008-1470331620', '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:04:18 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:04:18 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:04:18 INFO - Using env: {'DISPLAY': ':0', 11:04:18 INFO - 'HOME': '/home/cltbld', 11:04:18 INFO - 'LANG': 'en_US.UTF-8', 11:04:18 INFO - 'LANGUAGE': 'en_US:en', 11:04:18 INFO - 'LOGNAME': 'cltbld', 11:04:18 INFO - 'MAIL': '/var/mail/cltbld', 11:04:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:04:18 INFO - 'MOZ_NO_REMOTE': '1', 11:04:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:04:18 INFO - 'NO_EM_RESTART': '1', 11:04:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:04:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:04:18 INFO - 'PWD': '/builds/slave/test', 11:04:18 INFO - 'SHELL': '/bin/bash', 11:04:18 INFO - 'SHLVL': '1', 11:04:18 INFO - 'TERM': 'linux', 11:04:18 INFO - 'TMOUT': '86400', 11:04:18 INFO - 'USER': 'cltbld', 11:04:18 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1504807422.634008-1470331620', 11:04:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:04:18 INFO - '_': '/tools/buildbot/bin/python'} 11:04:20 INFO - Ignoring indexes: http://pypi.python.org/simple/ 11:04:20 INFO - Downloading/unpacking pip>=1.5 11:04:20 INFO - Running setup.py egg_info for package pip 11:04:20 INFO - warning: no files found matching 'pip/cacert.pem' 11:04:20 INFO - warning: no files found matching '*.html' under directory 'docs' 11:04:20 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:04:20 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:04:20 INFO - Installing collected packages: pip 11:04:20 INFO - Found existing installation: pip 1.1 11:04:20 INFO - Uninstalling pip: 11:04:20 INFO - Successfully uninstalled pip 11:04:20 INFO - Running setup.py install for pip 11:04:20 INFO - warning: no files found matching 'pip/cacert.pem' 11:04:20 INFO - warning: no files found matching '*.html' under directory 'docs' 11:04:20 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:04:20 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:04:20 INFO - Installing pip script to /builds/slave/test/build/venv/bin 11:04:20 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 11:04:20 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 11:04:20 INFO - Successfully installed pip 11:04:20 INFO - Cleaning up... 11:04:20 INFO - Return code: 0 11:04:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:04: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:04:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:04: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:04:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:04:20 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 0x19131f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c7fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c83090>, '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 0x1c83d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c7df90>, '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': '0e2a256762fed810e2f0f810000001b3-1504807422.634008-1470331620', '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:04:20 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:04:20 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:04:20 INFO - Using env: {'DISPLAY': ':0', 11:04:20 INFO - 'HOME': '/home/cltbld', 11:04:20 INFO - 'LANG': 'en_US.UTF-8', 11:04:20 INFO - 'LANGUAGE': 'en_US:en', 11:04:20 INFO - 'LOGNAME': 'cltbld', 11:04:20 INFO - 'MAIL': '/var/mail/cltbld', 11:04:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:04:20 INFO - 'MOZ_NO_REMOTE': '1', 11:04:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:04:20 INFO - 'NO_EM_RESTART': '1', 11:04:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:04:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:04:20 INFO - 'PWD': '/builds/slave/test', 11:04:20 INFO - 'SHELL': '/bin/bash', 11:04:20 INFO - 'SHLVL': '1', 11:04:20 INFO - 'TERM': 'linux', 11:04:20 INFO - 'TMOUT': '86400', 11:04:20 INFO - 'USER': 'cltbld', 11:04:20 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1504807422.634008-1470331620', 11:04:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:04:20 INFO - '_': '/tools/buildbot/bin/python'} 11:04:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:04:20 INFO - Downloading/unpacking psutil>=3.1.1 11:04:20 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:04:20 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:04:20 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:04:20 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:04:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:04:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:04:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:04:21 INFO - Installing collected packages: psutil 11:04:21 INFO - Running setup.py install for psutil 11:04:22 INFO - building 'psutil._psutil_linux' extension 11:04:22 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:04:23 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:04:23 INFO - building 'psutil._psutil_posix' extension 11:04:23 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:04:23 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:04:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:04:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:04:23 INFO - Successfully installed psutil 11:04:23 INFO - Cleaning up... 11:04:23 INFO - Return code: 0 11:04:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:04:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:04:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:04:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:04:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:04:23 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 0x19131f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c7fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c83090>, '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 0x1c83d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c7df90>, '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': '0e2a256762fed810e2f0f810000001b3-1504807422.634008-1470331620', '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:04:23 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:04:23 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:04:23 INFO - Using env: {'DISPLAY': ':0', 11:04:23 INFO - 'HOME': '/home/cltbld', 11:04:23 INFO - 'LANG': 'en_US.UTF-8', 11:04:23 INFO - 'LANGUAGE': 'en_US:en', 11:04:23 INFO - 'LOGNAME': 'cltbld', 11:04:23 INFO - 'MAIL': '/var/mail/cltbld', 11:04:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:04:23 INFO - 'MOZ_NO_REMOTE': '1', 11:04:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:04:23 INFO - 'NO_EM_RESTART': '1', 11:04:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:04:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:04:23 INFO - 'PWD': '/builds/slave/test', 11:04:23 INFO - 'SHELL': '/bin/bash', 11:04:23 INFO - 'SHLVL': '1', 11:04:23 INFO - 'TERM': 'linux', 11:04:23 INFO - 'TMOUT': '86400', 11:04:23 INFO - 'USER': 'cltbld', 11:04:23 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1504807422.634008-1470331620', 11:04:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:04:23 INFO - '_': '/tools/buildbot/bin/python'} 11:04:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:04:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:04:23 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:04:23 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:04:23 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:04:23 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:04:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:04:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:04:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:04:25 INFO - Installing collected packages: mozsystemmonitor 11:04:25 INFO - Running setup.py install for mozsystemmonitor 11:04:25 INFO - Successfully installed mozsystemmonitor 11:04:25 INFO - Cleaning up... 11:04:25 INFO - Return code: 0 11:04:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:04:25 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:04:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:04:25 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:04:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:04:25 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 0x19131f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c7fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c83090>, '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 0x1c83d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c7df90>, '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': '0e2a256762fed810e2f0f810000001b3-1504807422.634008-1470331620', '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:04:25 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:04:25 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:04:25 INFO - Using env: {'DISPLAY': ':0', 11:04:25 INFO - 'HOME': '/home/cltbld', 11:04:25 INFO - 'LANG': 'en_US.UTF-8', 11:04:25 INFO - 'LANGUAGE': 'en_US:en', 11:04:25 INFO - 'LOGNAME': 'cltbld', 11:04:25 INFO - 'MAIL': '/var/mail/cltbld', 11:04:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:04:25 INFO - 'MOZ_NO_REMOTE': '1', 11:04:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:04:25 INFO - 'NO_EM_RESTART': '1', 11:04:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:04:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:04:25 INFO - 'PWD': '/builds/slave/test', 11:04:25 INFO - 'SHELL': '/bin/bash', 11:04:25 INFO - 'SHLVL': '1', 11:04:25 INFO - 'TERM': 'linux', 11:04:25 INFO - 'TMOUT': '86400', 11:04:25 INFO - 'USER': 'cltbld', 11:04:25 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1504807422.634008-1470331620', 11:04:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:04:25 INFO - '_': '/tools/buildbot/bin/python'} 11:04:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:04:26 INFO - Downloading/unpacking jsonschema==2.5.1 11:04:26 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:04:26 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:04:26 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:04:26 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:04:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:04:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:04:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:04:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:04:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:04:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:04:27 INFO - Downloading functools32-3.2.3-2.tar.gz 11:04:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:04:27 INFO - warning: no files found matching '*.txt' 11:04:27 INFO - no previously-included directories found matching 'build' 11:04:27 INFO - no previously-included directories found matching 'dist' 11:04:27 INFO - no previously-included directories found matching '.git*' 11:04:27 INFO - Installing collected packages: jsonschema, functools32 11:04:27 INFO - Running setup.py install for functools32 11:04:27 INFO - warning: no files found matching '*.txt' 11:04:27 INFO - no previously-included directories found matching 'build' 11:04:27 INFO - no previously-included directories found matching 'dist' 11:04:27 INFO - no previously-included directories found matching '.git*' 11:04:27 INFO - Successfully installed jsonschema functools32 11:04:27 INFO - Cleaning up... 11:04:27 INFO - Return code: 0 11:04:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:04: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:04:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:04: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:04:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:04:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x19131f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c7fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c83090>, '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 0x1c83d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c7df90>, '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': '0e2a256762fed810e2f0f810000001b3-1504807422.634008-1470331620', '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:04:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:04:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:04:27 INFO - Using env: {'DISPLAY': ':0', 11:04:27 INFO - 'HOME': '/home/cltbld', 11:04:27 INFO - 'LANG': 'en_US.UTF-8', 11:04:27 INFO - 'LANGUAGE': 'en_US:en', 11:04:27 INFO - 'LOGNAME': 'cltbld', 11:04:27 INFO - 'MAIL': '/var/mail/cltbld', 11:04:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:04:27 INFO - 'MOZ_NO_REMOTE': '1', 11:04:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:04:27 INFO - 'NO_EM_RESTART': '1', 11:04:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:04:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:04:27 INFO - 'PWD': '/builds/slave/test', 11:04:27 INFO - 'SHELL': '/bin/bash', 11:04:27 INFO - 'SHLVL': '1', 11:04:27 INFO - 'TERM': 'linux', 11:04:27 INFO - 'TMOUT': '86400', 11:04:27 INFO - 'USER': 'cltbld', 11:04:27 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1504807422.634008-1470331620', 11:04:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:04:27 INFO - '_': '/tools/buildbot/bin/python'} 11:04:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:04:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:04:27 INFO - Cleaning up... 11:04:27 INFO - Return code: 0 11:04:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:04: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:04:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:04: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:04:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:04:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x19131f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c7fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c83090>, '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 0x1c83d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c7df90>, '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': '0e2a256762fed810e2f0f810000001b3-1504807422.634008-1470331620', '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:04:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:04:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:04:27 INFO - Using env: {'DISPLAY': ':0', 11:04:27 INFO - 'HOME': '/home/cltbld', 11:04:27 INFO - 'LANG': 'en_US.UTF-8', 11:04:27 INFO - 'LANGUAGE': 'en_US:en', 11:04:27 INFO - 'LOGNAME': 'cltbld', 11:04:27 INFO - 'MAIL': '/var/mail/cltbld', 11:04:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:04:27 INFO - 'MOZ_NO_REMOTE': '1', 11:04:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:04:27 INFO - 'NO_EM_RESTART': '1', 11:04:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:04:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:04:27 INFO - 'PWD': '/builds/slave/test', 11:04:27 INFO - 'SHELL': '/bin/bash', 11:04:27 INFO - 'SHLVL': '1', 11:04:27 INFO - 'TERM': 'linux', 11:04:27 INFO - 'TMOUT': '86400', 11:04:27 INFO - 'USER': 'cltbld', 11:04:27 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1504807422.634008-1470331620', 11:04:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:04:27 INFO - '_': '/tools/buildbot/bin/python'} 11:04:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:04:28 INFO - Downloading/unpacking blobuploader==1.2.4 11:04:28 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:04:28 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:04:28 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:04:28 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:04:29 INFO - Downloading blobuploader-1.2.4.tar.gz 11:04:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:04:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:04:29 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:04:29 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:04:29 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:04:29 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:04:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:04:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:04:29 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:04:29 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:04:29 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:04:29 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:04:29 INFO - Downloading docopt-0.6.1.tar.gz 11:04:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:04:29 INFO - Installing collected packages: blobuploader, requests, docopt 11:04:29 INFO - Running setup.py install for blobuploader 11:04:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:04:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:04:29 INFO - Running setup.py install for requests 11:04:30 INFO - Running setup.py install for docopt 11:04:30 INFO - Successfully installed blobuploader requests docopt 11:04:30 INFO - Cleaning up... 11:04:30 INFO - Return code: 0 11:04:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:04:30 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:04:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:04:30 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:04:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:04:30 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 0x19131f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c7fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c83090>, '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 0x1c83d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c7df90>, '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': '0e2a256762fed810e2f0f810000001b3-1504807422.634008-1470331620', '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:04:30 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:04:30 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:04:30 INFO - Using env: {'DISPLAY': ':0', 11:04:30 INFO - 'HOME': '/home/cltbld', 11:04:30 INFO - 'LANG': 'en_US.UTF-8', 11:04:30 INFO - 'LANGUAGE': 'en_US:en', 11:04:30 INFO - 'LOGNAME': 'cltbld', 11:04:30 INFO - 'MAIL': '/var/mail/cltbld', 11:04:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:04:30 INFO - 'MOZ_NO_REMOTE': '1', 11:04:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:04:30 INFO - 'NO_EM_RESTART': '1', 11:04:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:04:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:04:30 INFO - 'PWD': '/builds/slave/test', 11:04:30 INFO - 'SHELL': '/bin/bash', 11:04:30 INFO - 'SHLVL': '1', 11:04:30 INFO - 'TERM': 'linux', 11:04:30 INFO - 'TMOUT': '86400', 11:04:30 INFO - 'USER': 'cltbld', 11:04:30 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1504807422.634008-1470331620', 11:04:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:04:30 INFO - '_': '/tools/buildbot/bin/python'} 11:04:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:04:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:04:30 INFO - Running setup.py (path:/tmp/pip-clkKp7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:04:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:04:30 INFO - Running setup.py (path:/tmp/pip-_pN8CJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:04:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:04:30 INFO - Running setup.py (path:/tmp/pip-YM3IEe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:04:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:04:30 INFO - Running setup.py (path:/tmp/pip-tszKbt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:04:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:04:30 INFO - Running setup.py (path:/tmp/pip-uhW074-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:04:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:04:30 INFO - Running setup.py (path:/tmp/pip-XGk4Y0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:04:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:04:30 INFO - Running setup.py (path:/tmp/pip-garI8s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:04:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:04:31 INFO - Running setup.py (path:/tmp/pip-YtTLfZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:04:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:04:31 INFO - Running setup.py (path:/tmp/pip-NxlpcU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:04:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:04:31 INFO - Running setup.py (path:/tmp/pip-F7WZb1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:04:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:04:31 INFO - Running setup.py (path:/tmp/pip-otgHNv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:04:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:04:31 INFO - Running setup.py (path:/tmp/pip-zUydtB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:04:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:04:31 INFO - Running setup.py (path:/tmp/pip-nTLilt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:04:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:04:31 INFO - Running setup.py (path:/tmp/pip-2IYgNj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:04:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:04:31 INFO - Running setup.py (path:/tmp/pip-xC4Pml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:04:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:04:31 INFO - Running setup.py (path:/tmp/pip-GME6kS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:04:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:04:31 INFO - Running setup.py (path:/tmp/pip-J95T6o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:04:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:04:31 INFO - Running setup.py install for manifestparser 11:04:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:04:31 INFO - Running setup.py install for mozcrash 11:04:31 INFO - Running setup.py install for mozdebug 11:04:32 INFO - Running setup.py install for mozdevice 11:04:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:04:32 INFO - Running setup.py install for mozfile 11:04:32 INFO - Running setup.py install for mozhttpd 11:04:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:04:32 INFO - Running setup.py install for mozinfo 11:04:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:04:32 INFO - Running setup.py install for mozInstall 11:04:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:04:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:04:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:04:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:04:32 INFO - Running setup.py install for mozleak 11:04:32 INFO - Running setup.py install for mozlog 11:04:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:04:32 INFO - Running setup.py install for moznetwork 11:04:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:04:32 INFO - Running setup.py install for mozprocess 11:04:32 INFO - Running setup.py install for mozprofile 11:04:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:04:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:04:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:04:33 INFO - Running setup.py install for mozrunner 11:04:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:04:33 INFO - Running setup.py install for mozscreenshot 11:04:33 INFO - Running setup.py install for moztest 11:04:33 INFO - Running setup.py install for mozversion 11:04:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:04:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:04:33 INFO - Cleaning up... 11:04:33 INFO - Return code: 0 11:04:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:04:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:04:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:04:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:04:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:04:33 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 0x19131f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c7fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c83090>, '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 0x1c83d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c7df90>, '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': '0e2a256762fed810e2f0f810000001b3-1504807422.634008-1470331620', '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:04:33 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:04:33 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:04:33 INFO - Using env: {'DISPLAY': ':0', 11:04:33 INFO - 'HOME': '/home/cltbld', 11:04:33 INFO - 'LANG': 'en_US.UTF-8', 11:04:33 INFO - 'LANGUAGE': 'en_US:en', 11:04:33 INFO - 'LOGNAME': 'cltbld', 11:04:33 INFO - 'MAIL': '/var/mail/cltbld', 11:04:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:04:33 INFO - 'MOZ_NO_REMOTE': '1', 11:04:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:04:33 INFO - 'NO_EM_RESTART': '1', 11:04:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:04:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:04:33 INFO - 'PWD': '/builds/slave/test', 11:04:33 INFO - 'SHELL': '/bin/bash', 11:04:33 INFO - 'SHLVL': '1', 11:04:33 INFO - 'TERM': 'linux', 11:04:33 INFO - 'TMOUT': '86400', 11:04:33 INFO - 'USER': 'cltbld', 11:04:33 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1504807422.634008-1470331620', 11:04:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:04:33 INFO - '_': '/tools/buildbot/bin/python'} 11:04:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:04:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:04:33 INFO - Running setup.py (path:/tmp/pip-GmLw9C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:04:33 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:04:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:04:33 INFO - Running setup.py (path:/tmp/pip-mKv5dR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:04:33 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:04:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:04:33 INFO - Running setup.py (path:/tmp/pip-mwwKJH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:04:33 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:04:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:04:33 INFO - Running setup.py (path:/tmp/pip-4A57DB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:04:34 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:04:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:04:34 INFO - Running setup.py (path:/tmp/pip-dYhMmb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:04:34 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:04:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:04:34 INFO - Running setup.py (path:/tmp/pip-OsJ7le-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:04:34 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:04:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:04:34 INFO - Running setup.py (path:/tmp/pip-lDip7A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:04:34 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:04:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:04:34 INFO - Running setup.py (path:/tmp/pip-n_HIT8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:04:34 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:04:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:04:34 INFO - Running setup.py (path:/tmp/pip-mzwqLJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:04:34 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:04:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:04:34 INFO - Running setup.py (path:/tmp/pip-bVNOs_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:04:34 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:04:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:04:34 INFO - Running setup.py (path:/tmp/pip-X8wZyO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:04:34 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:04:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:04:34 INFO - Running setup.py (path:/tmp/pip-ifDq4u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:04:34 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:04:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:04:34 INFO - Running setup.py (path:/tmp/pip-qAJgsy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:04:34 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:04:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:04:34 INFO - Running setup.py (path:/tmp/pip-4BmqqJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:04:34 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:04:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:04:34 INFO - Running setup.py (path:/tmp/pip-xXMKWW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:04:34 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:04:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:04:34 INFO - Running setup.py (path:/tmp/pip-VkiKbj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:04:34 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:04:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:04:34 INFO - Running setup.py (path:/tmp/pip-KOK2IA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:04:34 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:04:34 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:04:34 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:04:34 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:04:34 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:04:34 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:04:34 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:04:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:04:34 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:04:34 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:04:34 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:04:34 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:04:36 INFO - Downloading blessings-1.6.tar.gz 11:04:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:04:36 INFO - Installing collected packages: blessings 11:04:36 INFO - Running setup.py install for blessings 11:04:36 INFO - Successfully installed blessings 11:04:36 INFO - Cleaning up... 11:04:36 INFO - Return code: 0 11:04:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:04:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:04:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:04:36 INFO - Reading from file tmpfile_stdout 11:04:36 INFO - Current package versions: 11:04:36 INFO - argparse == 1.2.1 11:04:36 INFO - blessings == 1.6 11:04:36 INFO - blobuploader == 1.2.4 11:04:36 INFO - docopt == 0.6.1 11:04:36 INFO - functools32 == 3.2.3-2 11:04:36 INFO - jsonschema == 2.5.1 11:04:36 INFO - manifestparser == 1.1 11:04:36 INFO - mozInstall == 1.13 11:04:36 INFO - mozcrash == 1.0 11:04:36 INFO - mozdebug == 0.1 11:04:36 INFO - mozdevice == 0.51 11:04:36 INFO - mozfile == 1.2 11:04:36 INFO - mozhttpd == 0.7 11:04:36 INFO - mozinfo == 0.10 11:04:36 INFO - mozleak == 0.1 11:04:36 INFO - mozlog == 3.5 11:04:36 INFO - moznetwork == 0.27 11:04:36 INFO - mozprocess == 0.25 11:04:36 INFO - mozprofile == 0.28 11:04:36 INFO - mozrunner == 6.13 11:04:36 INFO - mozscreenshot == 0.1 11:04:36 INFO - mozsystemmonitor == 0.3 11:04:36 INFO - moztest == 0.8 11:04:36 INFO - mozversion == 1.4 11:04:36 INFO - psutil == 3.1.1 11:04:36 INFO - requests == 1.2.3 11:04:36 INFO - wsgiref == 0.1.2 11:04:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:04:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:04:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:04:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:04:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:04:36 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 0x19131f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c7fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c83090>, '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 0x1c83d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c7df90>, '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': '0e2a256762fed810e2f0f810000001b3-1504807422.634008-1470331620', '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:04:36 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:04:36 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:04:36 INFO - Using env: {'DISPLAY': ':0', 11:04:36 INFO - 'HOME': '/home/cltbld', 11:04:36 INFO - 'LANG': 'en_US.UTF-8', 11:04:36 INFO - 'LANGUAGE': 'en_US:en', 11:04:36 INFO - 'LOGNAME': 'cltbld', 11:04:36 INFO - 'MAIL': '/var/mail/cltbld', 11:04:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:04:36 INFO - 'MOZ_NO_REMOTE': '1', 11:04:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:04:36 INFO - 'NO_EM_RESTART': '1', 11:04:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:04:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:04:36 INFO - 'PWD': '/builds/slave/test', 11:04:36 INFO - 'SHELL': '/bin/bash', 11:04:36 INFO - 'SHLVL': '1', 11:04:36 INFO - 'TERM': 'linux', 11:04:36 INFO - 'TMOUT': '86400', 11:04:36 INFO - 'USER': 'cltbld', 11:04:36 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1504807422.634008-1470331620', 11:04:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:04:36 INFO - '_': '/tools/buildbot/bin/python'} 11:04:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:04:36 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:04:36 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:04:36 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:04:36 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:04:36 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:04:36 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:04:36 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:04:36 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:04:36 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:04:36 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:04:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:04:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:04:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:04:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:04:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:04:37 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:04:37 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:04:37 INFO - Installing collected packages: simplejson 11:04:37 INFO - Running setup.py install for simplejson 11:04:38 INFO - building 'simplejson._speedups' extension 11:04:38 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:04:38 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:04:38 INFO - Successfully installed simplejson 11:04:38 INFO - Cleaning up... 11:04:39 INFO - Return code: 0 11:04:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:04:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:04:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:04:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:04:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:04:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19131f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c7fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c83090>, '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 0x1c83d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c7df90>, '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': '0e2a256762fed810e2f0f810000001b3-1504807422.634008-1470331620', '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:04:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:04:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:04:39 INFO - Using env: {'DISPLAY': ':0', 11:04:39 INFO - 'HOME': '/home/cltbld', 11:04:39 INFO - 'LANG': 'en_US.UTF-8', 11:04:39 INFO - 'LANGUAGE': 'en_US:en', 11:04:39 INFO - 'LOGNAME': 'cltbld', 11:04:39 INFO - 'MAIL': '/var/mail/cltbld', 11:04:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:04:39 INFO - 'MOZ_NO_REMOTE': '1', 11:04:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:04:39 INFO - 'NO_EM_RESTART': '1', 11:04:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:04:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:04:39 INFO - 'PWD': '/builds/slave/test', 11:04:39 INFO - 'SHELL': '/bin/bash', 11:04:39 INFO - 'SHLVL': '1', 11:04:39 INFO - 'TERM': 'linux', 11:04:39 INFO - 'TMOUT': '86400', 11:04:39 INFO - 'USER': 'cltbld', 11:04:39 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1504807422.634008-1470331620', 11:04:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:04:39 INFO - '_': '/tools/buildbot/bin/python'} 11:04:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:04:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:04:39 INFO - Cleaning up... 11:04:39 INFO - Return code: 0 11:04:39 INFO - Running post-action listener: _resource_record_post_action 11:04:39 INFO - Running post-action listener: _start_resource_monitoring 11:04:39 INFO - Starting resource monitoring. 11:04:39 INFO - [mozharness: 2017-09-07 18:04:39.300640Z] Finished create-virtualenv step (success) 11:04:39 INFO - [mozharness: 2017-09-07 18:04:39.301627Z] Running install step. 11:04:39 INFO - Running pre-action listener: _resource_record_pre_action 11:04:39 INFO - Running main action method: install 11:04:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:04:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:04:39 INFO - Reading from file tmpfile_stdout 11:04:39 INFO - Detecting whether we're running mozinstall >=1.0... 11:04:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:04:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:04:39 INFO - Reading from file tmpfile_stdout 11:04:39 INFO - Output received: 11:04:39 INFO - Usage: mozinstall [options] installer 11:04:39 INFO - Options: 11:04:39 INFO - -h, --help show this help message and exit 11:04:39 INFO - -d DEST, --destination=DEST 11:04:39 INFO - Directory to install application into. [default: 11:04:39 INFO - "/builds/slave/test"] 11:04:39 INFO - --app=APP Application being installed. [default: firefox] 11:04:39 INFO - mkdir: /builds/slave/test/build/application 11:04:39 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:04:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:04:56 INFO - Reading from file tmpfile_stdout 11:04:56 INFO - Output received: 11:04:56 INFO - /builds/slave/test/build/application/firefox/firefox 11:04:56 INFO - Running post-action listener: _resource_record_post_action 11:04:56 INFO - [mozharness: 2017-09-07 18:04:56.159601Z] Finished install step (success) 11:04:56 INFO - [mozharness: 2017-09-07 18:04:56.159852Z] Running setup-mitmproxy step. 11:04:56 INFO - Running pre-action listener: _resource_record_pre_action 11:04:56 INFO - Running main action method: setup_mitmproxy 11:04:56 INFO - Skipping: mitmproxy is not required 11:04:56 INFO - Running post-action listener: _resource_record_post_action 11:04:56 INFO - [mozharness: 2017-09-07 18:04:56.160980Z] Finished setup-mitmproxy step (success) 11:04:56 INFO - [mozharness: 2017-09-07 18:04:56.161197Z] Running run-tests step. 11:04:56 INFO - Running pre-action listener: _resource_record_pre_action 11:04:56 INFO - Running pre-action listener: _set_gcov_prefix 11:04:56 INFO - Running main action method: run_tests 11:04:56 WARNING - Try message not found. 11:04:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:04:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:04:56 INFO - Python 2.7.3 11:04:56 INFO - Return code: 0 11:04:56 INFO - grabbing minidump binary from tooltool 11:04:56 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:04:56 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 0x1c83090>, '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 0x1c83d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c7df90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:04:56 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:04:56 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:04:56 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:04:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:04:56 INFO - Return code: 0 11:04:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:04:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:04:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:04:56 INFO - ENV: RUST_BACKTRACE is now full 11:04:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:04:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:04:56 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/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--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:04:56 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/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-058 --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:04:56 INFO - Using env: {'DISPLAY': ':0', 11:04:56 INFO - 'HOME': '/home/cltbld', 11:04:56 INFO - 'LANG': 'en_US.UTF-8', 11:04:56 INFO - 'LANGUAGE': 'en_US:en', 11:04:56 INFO - 'LOGNAME': 'cltbld', 11:04:56 INFO - 'MAIL': '/var/mail/cltbld', 11:04:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:04:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:04:56 INFO - 'MOZ_ACCELERATED': '1', 11:04:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:04:56 INFO - 'MOZ_NO_REMOTE': '1', 11:04:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:04:56 INFO - 'MOZ_WEBRENDER': '1', 11:04:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:04:56 INFO - 'NO_EM_RESTART': '1', 11:04:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:04:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:04:56 INFO - 'PWD': '/builds/slave/test', 11:04:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:04:56 INFO - 'RUST_BACKTRACE': 'full', 11:04:56 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:04:56 INFO - 'SHELL': '/bin/bash', 11:04:56 INFO - 'SHLVL': '1', 11:04:56 INFO - 'TERM': 'linux', 11:04:56 INFO - 'TMOUT': '86400', 11:04:56 INFO - 'USER': 'cltbld', 11:04:56 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1504807422.634008-1470331620', 11:04:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:04:56 INFO - '_': '/tools/buildbot/bin/python'} 11:04:56 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/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--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:04:56 INFO - mozversion application_buildid: 20170907171306 11:04:56 INFO - mozversion application_changeset: 3c96d611ebd67fc219d22bcb476a72412c76f6c7 11:04:56 INFO - mozversion application_display_name: Nightly 11:04:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:04:56 INFO - mozversion application_name: Firefox 11:04:56 INFO - mozversion application_remotingname: firefox 11:04:56 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:04:56 INFO - mozversion application_vendor: Mozilla 11:04:56 INFO - mozversion application_version: 57.0a1 11:04:56 INFO - mozversion platform_buildid: 20170907171306 11:04:56 INFO - mozversion platform_changeset: 3c96d611ebd67fc219d22bcb476a72412c76f6c7 11:04:56 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:04:56 INFO - mozversion platform_version: 57.0a1 11:04:56 INFO - using testdate: 1504807496 11:04:56 INFO - actual date: 1504807496 11:04:56 INFO - starting webserver on 'localhost:57086' 11:04:56 INFO - SUITE-START | Running 2 tests 11:04:56 INFO - TEST-START | dromaeo_css 11:04:56 INFO - Initialising browser for dromaeo_css test... 11:04:56 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:57086/getInfo.html -profile /tmp/tmpeIxrbe/profile 11:04:56 INFO - TEST-INFO | started process 3547 (/builds/slave/test/build/application/firefox/firefox http://localhost:57086/getInfo.html) 11:05:06 INFO - TEST-INFO | 3547: exit 0 11:05:06 INFO - Browser initialized. 11:05:06 INFO - Running cycle 1/1 for dromaeo_css test... 11:05:06 INFO - Using env: {'DISPLAY': ':0', 11:05:06 INFO - 'HOME': '/home/cltbld', 11:05:06 INFO - 'JSGC_DISABLE_POISONING': '1', 11:05:06 INFO - 'LANG': 'en_US.UTF-8', 11:05:06 INFO - 'LANGUAGE': 'en_US:en', 11:05:06 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:05:06 INFO - 'LOGNAME': 'cltbld', 11:05:06 INFO - 'MAIL': '/var/mail/cltbld', 11:05:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:05:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:05:06 INFO - 'MOZ_ACCELERATED': '1', 11:05:06 INFO - 'MOZ_CRASHREPORTER': '1', 11:05:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:06 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:05:06 INFO - 'MOZ_NO_REMOTE': '1', 11:05:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:05:06 INFO - 'MOZ_WEBRENDER': '1', 11:05:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:05:06 INFO - 'NO_EM_RESTART': '1', 11:05:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:05:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:05:06 INFO - 'PWD': '/builds/slave/test', 11:05:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:05:06 INFO - 'RUST_BACKTRACE': 'full', 11:05:06 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:05:06 INFO - 'SHELL': '/bin/bash', 11:05:06 INFO - 'SHLVL': '1', 11:05:06 INFO - 'TERM': 'linux', 11:05:06 INFO - 'TMOUT': '86400', 11:05:06 INFO - 'USER': 'cltbld', 11:05:06 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1504807422.634008-1470331620', 11:05:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:06 INFO - '_': '/tools/buildbot/bin/python'} 11:05:06 INFO - TEST-INFO | started process 3760 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeIxrbe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:05:07 INFO - PID 3760 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 11:05:07 INFO - PID 3760 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 11:05:07 INFO - PID 3760 | 11:05:07 INFO - PID 3760 | (/builds/slave/test/build/application/firefox/firefox:3822): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:05:07 INFO - PID 3760 | 11:05:18 INFO - PID 3760 | RSS: Main: 214528000 11:05:18 INFO - PID 3760 | 11:08:16 INFO - PID 3760 | Cycle 1(1): loaded http://localhost:57086/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57086/tests/dromaeo/cssquery-ext.html) 11:08:17 INFO - PID 3760 | RSS: Main: 227868672 11:08:17 INFO - PID 3760 | 11:11:20 INFO - PID 3760 | Cycle 1(1): loaded http://localhost:57086/tests/dromaeo/cssquery-ext.html (next: http://localhost:57086/tests/dromaeo/cssquery-jquery.html) 11:11:20 INFO - PID 3760 | RSS: Main: 224669696 11:11:20 INFO - PID 3760 | 11:14:22 INFO - PID 3760 | Cycle 1(1): loaded http://localhost:57086/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57086/tests/dromaeo/cssquery-mootools.html) 11:14:23 INFO - PID 3760 | RSS: Main: 226512896 11:14:23 INFO - PID 3760 | 11:17:25 INFO - PID 3760 | Cycle 1(1): loaded http://localhost:57086/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57086/tests/dromaeo/cssquery-prototype.html) 11:17:26 INFO - PID 3760 | RSS: Main: 226160640 11:17:26 INFO - PID 3760 | 11:20:29 INFO - PID 3760 | Cycle 1(1): loaded http://localhost:57086/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57086/tests/dromaeo/cssquery-yui.html) 11:20:30 INFO - PID 3760 | RSS: Main: 229539840 11:20:30 INFO - PID 3760 | 11:23:32 INFO - PID 3760 | Cycle 1(1): loaded http://localhost:57086/tests/dromaeo/cssquery-yui.html (next: http://localhost:57086/tests/dromaeo/cssquery-dojo.html) 11:23:32 INFO - PID 3760 | RSS: Main: 229429248 11:23:32 INFO - PID 3760 | 11:23:32 INFO - PID 3760 | __start_tp_report 11:23:32 INFO - PID 3760 | _x_x_mozilla_page_load 11:23:32 INFO - PID 3760 | _x_x_mozilla_page_load_details 11:23:32 INFO - PID 3760 | |i|pagename|runs| 11:23:32 INFO - PID 3760 | |0;dojo.html;3239.4007108684896;3251.2359595495063;3258.185453636591;3294.176455886027;3318.2865683877976;6214.06788981653;6332.9683351583235;6401.51988600855;6438.002109673002;6439.839004024901;6203.875922481548;6232.719527621257;6262.686865656722;6285.088662143987;6288.276848162463;5723.627964182325;5745.080787074069;5778.335491418477;5915.142304365864;5939.109133629969;5806.59353845231;5852.385499522531;5871.970640146793;5877.853053673671;5926.555508336871;1296.9607220619555;5674.943250567483;5704.515116215127;5851;5962.1951036609935;5624.100143976944;5686.658800471943;5779.335376431723;5812.941870581282;5864.266966629171;5743.770249190027;5789.755202631412;5850.502707269845;5851.444112809277;5856.32652244993;6295.937040629581;6295.937040629581;6335.334789847046;6351.269603995554;6416.647084410356;6705.295943925867;6717.664116794141;6779.305906825732;6793.762218322335;6870.5534140281225;6845.589264644137;6846.931530684729;6906.792796216121;6919.031335613018;6934.549254298455;6097.451229389376;6173.506119510428;6180.2892667343385;6192.411720886508;6201.565890387675;6873.1064961554675;6882.8967565486555;6895.448364130857;6906.06768086312;6990.370866622028;6588.8023359299295;6695.062691223233;6709.832254193684;6713.664316784141;6723.462123030145;6671.532992690562;6714.664266786641;6834;6852.903535434307;6856.485763567753;6683.2648408675;6722.092517510074;6739.696713647898;6816.4546836252985;6822.761203357859;6489.70796314167;6594.802155935329;6736.292689267654;6831.11195544576;6865.107536020385;5405.7837686492885;5407.513323800877;5413.566914646819;5422.024035673617;5428.728563571805;4665.533446655375;4718.976405117953;4780.545848144421;4799.3760811095035;4811.927821082687;5903.439173278532;5918.348981612019;5970.13433052205;6003.309619393738;6004.219451471281;6564.770233041821;6665.166854143232;6729.427998620172;6733.124693789776;6927.861442771116;5796;5805.245318108618;5832.941670583325;5856.443637854397;5862.824115276549;5779.3642699303045;5797.072468405119;5859.121131830259;5876.324222714443;5893.057110862242;6566.24488183865;6602;6609.272979972199;6625.503087268377;6670.599764014175;6734.730610775514;6783.626900520519;6835.487338449537;6861;6872.450203983769;6562.146920900253;6562.934370656232;6630.370114839083;6658.700358483977;6674.632895190811;6499.38255865692;6702.430293425114;6710.63091529951;6773.525853190229;6821.93178068213;6569.441597464269;6709.530332876652;6712.160979877515;6725.226598941184;6733.898991515033;6490.513211509061;6500.284968653539;6512.446442052478;6514.609123452418;6542.803715888531;6275.121482992294;6440.32376600469;6518.608883467007;6591.571547849375;6616.338366163345;6309.49524038085;6337.334579869047;6350.364963503613;6420.7431702731365;6426.132472116392;6489.675516224075;6520.576162549419;6538.607683539003;6566.770163044271;6658.600483970978;6258.561900666909;6323.177986861862;6379.106925030592;6463.741450341934;6492.220933487823 11:23:32 INFO - PID 3760 | |1;ext.html;839.1356902390538;869.0223498564116;870.9564521773909;871.1462766488838;872.149654087265;38823;42318.57681423185;42739;42857;43065.56934430655;39052;39310;39494.80252598733;39765.60234397655;39797.40303895437;6957.965210173942;6995.370416662499;7005.439564834826;7054.576725396492;7073.646317684121;6891.689873955659;6972.860542789142;6985.336393042653;6993.615351155684;7019.368256856882;7034.05040319558;7065.2228254891925;7726.304632583066;7932.960335198316;7945.324647404977;7812.726554570591;7887.408444366695;7894.052713674396;7896.170902055316;7903.881441778378;7623.542587444771;7705.113911900091;7714.729984450573;7714.765637497973;7775.222477752236;38533.80733096345;38570.421443678366;39281.60718392837;39346.60653393458;39402.21195576072;3544.769589976643;3556.8399422025814;3584.551931008624;3598.208394153282;3615.6384361563896;32024.519632205534;32109.197270068435;32342.191445213823;32346.6765332346;32351.6764832351;5102.6428150029515;5115.974420127913;5116.795328186868;5130.71781052042;5136.974315128437;221187;229202;229524;230006;230583.9999999983;42609.78695106567;43419;49396.75301623469;49654.503454964986;49884.25173622399;52427.21359179616;52548.73725631347;52642.47357526452;52714;52871.735641321546;15896.364145434285;15989.920050399674;15992.120433376276;16026.118563478887;16029.278682459317;13031.957443404504;13074.542391016268;13095.886849617698;13103.803442948363;13119.737605247841;14295.213763242913;14419.63950901215;14424.134551926918;14482.782758258634;14706.117632942058;5786.566007549451;5788.710564471759;5869.178315035899;5929.37741537141;5976.073708575178;957.5882370580578;968.3560432312574;975.4781192062354;978.188103873783;987.9407235565889;22179.44551386196;22255;22390;22408.66387004196;22998;1080.103514083309;1083.4041277297456;1087.798757229915;1088.5754555723274;1092.759592889563;11824.586139485076;11986.760264794655;11996.160268781101;11998.820017699742;12035.518579256906;228101;229112;229871;230173;231950;54277;54644.72677636586;54917.45082549203;54984.17523737147;55119.173212401845;1426.9500567480295;1464.699736554025;1473.7715654073636;1487.0631502153574;1492.5895378770708;21842;21854.45363865916;22011.559768804855;22230.77769222287;22611.43471413228;34027.65972340245;34266.657333426345;34281;34306;34324;191429;192640;192840;193014;193743;30609.387812243185;32936;33837.32325353529;34662.48006279958;34986;41283.38074928938;43527.34708979431;43772.78113609411;44023;44052;31917.20206994844;32130.83934580312;32310.192245193117;32352.514712278862;32488.51267230946;31979;32127;32165;32333.838330809136;32825.17937051593;35920.820395897856;35933;35977.460338094425;36123.458148127276;36359.63640363669;31553.21116972094;31888;32157.03528894137;33740.325193495504;35074.82462587773;24334.148304809245;24907;24908.62637060409;24942.95365544987;25395 11:23:32 INFO - PID 3760 | |2;jquery.html;533.7571405010721;553.3442870198817;567.5828266224322;580.1442871764148;595.3153873045998;21928.780712192874;22787.31638050857;22794.65808012879;22885.084596616114;22986.65520017199;24094.397640058964;24728.75271247287;24741.38146546337;24928.376790580245;25152.37119072024;6518.185226846633;6701.195856497227;6706.564073335242;6711.261761206288;6730.764423245188;6604.207495100594;6700.597964122144;6727.226368967558;6738.898916516257;6744.7976560703255;6318.210223722035;6636.668166591675;6637.634930078843;6652.733890644368;6655.633940133291;6583.5062370322175;6622.503312251576;6626.204855417381;6672.633005184713;6674.16572928384;5859.794907178229;6058.273007239115;6126.326104128542;6162.815115546541;6172.4136207060255;27671.169864903884;27870.16389508318;28119.0158344459;28129.718702812916;28206.294842628893;2045.263705066175;2067.8966051697357;2081.6044951459176;2084.135083940163;2084.5622419291817;18504.167312470836;18865.811341886543;18947;19165.520861978563;19190.520236994187;2341.94145146371;2406.9037238510437;2412.6984126984125;2416.1422694943217;2429.2226487524;112015;119223.4038829809;133884.33057834746;138027;145645.27177364152;14394.712105758035;14439.422423103168;14465.27673616315;14582.562523124323;14625.6725748729;22627.547449050926;22672.206472773374;22694.319170424915;22710.545789084124;22825.771742282366;9781.85327220078;10148.898511014942;10219.284650074424;10235.846462303072;10325.225608079425;9460.385074970105;9569.760755981157;9675.5486676999;9762.75593110178;9806.264530160266;8653.394262401698;8794.86807697885;8893.155150260714;9129.269658427309;9182.494962777111;2582.138545501738;2610.8172427930244;2684.8120631555994;2711.972880271172;2760.6963234044238;918.963241470347;951.743029382063;958.5399008475971;961.8701475300885;970.9563069661741;19194.328198513263;19197.136128874234;19222.231110755412;19303;19761;1005.2661557063238;1018.332991890313;1021.3463383434607;1026.4764969865273;1038.787048655024;10487.895121048845;10527.526261318259;10568;10579.978351199357;10695;428148;435071;451629;454060;455552;116437;118413.4079329615;120120;129399;135041;1178.5933852820763;1182.3319824299244;1245.781988152088;1255.3534929511309;1263.7977923532374;20154.798452015293;20887.37337879866;20905.268315608882;21286;21325.573488529833;56419.43580564142;59273.40726592679;60506.39493605184;60558;60933.39066609454;70655.29344706693;71595.92606110808;71742;71884;72628.63685681538;14356.35396407185;14381.137131772128;14391.064580802215;14455.49405770793;14542.200178990257;22564.323070307917;22645.660315095618;22897.771022289562;22947.196848110238;23260.3021909343;17764.822351776318;18247.81752182461;18421.447356579323;18542.721859172394;18579.628407432047;16333.836661633706;16348.264328105026;16699.24853381625;16959.23683434273;16998.320067197667;18446.815531845048;18593.256269749058;18766.53083672919;18881.622367552296;18885;13824.792628110385;14167.64580885486;14264.928675356558;14435;14448.927755361156;18112.18495167747;18155.183016764015;18164.364247251284;18333.724994124834;18497.352592659194 11:23:32 INFO - PID 3760 | |3;mootools.html;1332.6335257804103;1391.7634002219622;1394.2610416479263;1400.4958215042584;1402.3549167383003;15057.397704091823;15505.379784808594;15510.991785533932;15588.688226235468;15636.140012299333;15397.384104635801;15476.690466190697;15564.533064008097;15579;15613.453529126482;2741.986290068547;2789.7768178545716;2812.409394027257;2819.1824370932404;2822.0969289827162;2631.868406579673;2740.7122252163535;2758.8620568971573;2763.6545431821023;2786.192004318755;2648.655674762278;2767.9723202767914;2782.819116757404;2784.4431113777223;2784.763295119917;2783.6520434945633;2808.0312292259136;2835.9858200709073;2843.1896909380935;2851.2016635342034;2688.3951111000065;2688.6101515280175;2694.5688689809535;2695.43395886864;2719.728027197284;14785.55643330691;15071.547853564301;15095.4716584919;15109.244537773067;15116.470923517734;7957.7612671619945;8212;8226.383021273428;8238.217369349963;8243.299319557846;5462.289902312714;5487.75305111271;5556.611037227396;5666.376698563155;5670.149477578355;1882.1342182596022;1905.6093500832435;1910.2263583248807;1931.5267759398896;1937.903104844752;26016.479670406487;26239.081632142974;26245;26310;26312.21063368102;7413.925860741431;7432.554046757212;7617.619119044026;7669;7675.15573286938;17040.233189506253;17109.572260693334;17255.3960611378;17258.654826903392;17295.65408691819;7786.7663970080985;7851;7951.483153594998;7960.601969901481;8124.309433698202;7251.4923955323675;7318.085239345082;7321.743738969217;7375.11498620169;7397.334239918433;5259.0804356409635;5364.946350536445;5415.1335786274;5423.593230507728;5470.781168753205;1320.7226482438602;1327.707904261061;1531.2649928034605;1533.0495093042161;1553.4640549010574;726.7093162734948;875.4572165257581;879.6481407437076;884.0540621534896;889.9644014239358;8546.829063418696;8665.653373865101;8747.693830715894;8764.649414023495;8839.29285657146;954.2175416158683;979.4515071559949;999.3654029691053;1003.8745156855393;1015.827309357411;5400.162974738922;5475.780968761205;5627;5634.549236061105;5657.632253903483;21502.247421340177;21777.455563610718;22000.44998875041;22028.229011984502;22398.664020039712;20525.48686282825;20945.58108837815;21410.143594256057;21688.240911568337;21694.45763855916;11133.554657813758;11488.310701357945;11734.11994100446;11737.765244695229;11738.70653233676;7935.444518883623;8648.481091134552;8737.825243494968;8890.377673562789;8916.55417229149;18479.81520184781;18652.626947461245;19047.238110475424;19149.521261968563;19249.23003079917;19012;19455.8054419454;19504.8049519503;19777.604447910675;19877.900610496854;9779.119879210904;10350.792984140426;10402.219833512669;10403.635872744419;10488.213383996079;13624.114432561852;13791;13796.793048104488;13812.86187138156;13820.032597718064;11233.831492527455;11373.658790236306;11394.886051139383;11585.7103572408;11589.188756787282;11163.330200188015;11297.15271354668;11396.430178491208;11434.542618295507;11654.417279136178;10047.849282260626;10082.04220599042;10144.391336519537;10174.186065114922;10240.692779216635;7402.925970740439;7567;7633.122190948112;7655.0813902332075;7777.805554860947;7929.682812687428;8004.719834805754;8013.759587212393;8016.318612917734;8037.075736290401 11:23:32 INFO - PID 3760 | |4;prototype.html;482.833422469248;514.7323391836245;518.085578953148;520.0431206579892;520.2950002746279;6423.554700192454;6434.646094464802;6446.548741588091;6488.416042556169;6512.348765123491;6277;6295.213098362705;6378.521610879179;6387.393197646228;6413.326600706917;4892.266160075999;5128.461461561516;5244.134717771563;5245.8950820983555;5246.7407822122605;5000.824971126011;5057;5066.97466512667;5089.109405853979;5100.234964755298;4947.505249475042;4983.9252411213865;4987.226979818116;5008.198688209887;5034.672746271499;4966.25506174075;5001.949980500185;5004.249362595603;5009.799608015675;5110.361204849394;4507.219648238927;4515.932261016087;4536.8638940831825;4547.522510136454;4551.704139230939;6198.349173336825;6231.813045608639;6253.781117660906;6275.246970363585;6332.145160403379;5730.169125476783;5757.913631295534;5792.189093526909;5832.795852145197;5840.737166827503;6676.198856137246;6699.229588597276;6714.563553369064;6732.326767323278;6768.39084482394;4924.655274130812;4944.381952255968;4955.1080805455;4960.379952505937;4962.727050012248;6742.359475849787;6864.318242030685;6933;6952.930470695279;7052.753153639598;5029.874253143701;5039.118154322979;5082.898342033212;5093.286939828427;5104.2343648453025;5060.746962651852;5092.643514953992;5110.463401342806;5137.640365174402;5182.97408512955;5756.65460072397;5780.16187652788;5790.36306006339;5803.767849285981;5851.502622277069;6725.66371681414;6738.056672065914;6759.932400676029;6766.966165169241;6796.558223715443;1749.3177660712333;1762.2510433065895;1778.0398584764082;1782.4028950301536;1788.7585176001332;1174.2308787744041;1215.6535387414544;1231.335079057317;1234.7839128152536;1257.440439004634;5785.479306862402;5840.503557197686;5849.064149736107;5854.356020837705;5885.3820348862755;6646.601203927683;6662.533622646465;6789.72841086351;6796.490263230277;6874.312568743086;5750.511206547407;5801.158831969341;5889.146073819272;5906.7637294508595;5920.733566989496;3561.878008427337;3569.696575791035;3637.618050104754;3659.524261845943;3670.541182352206;6574.572652777554;6675.599464032077;6722.159730033746;6767.52627316093;6771.002554246411;7051.1891132519395;7071.292870712888;7082.964585177041;7174.748883789042;7180.8922866157045;6603.712276106113;6642.933570664231;6666.799996000031;6703.798886033427;6753.1220941277315;6793.966030170015;6899.310068993061;6929.514933954575;6932.227109156176;6972.163340399185;6849.726010959505;6855.520113592001;6875.690593923386;6913.5506192097355;6942.409895158968;6708.463322934056;6718.757029949475;6728.966355168192;6758.86482270342;6760.93239067603;4976.850694479172;5029.170186919117;5056.165732654218;5067.670601410897;5108.61685373591;6610.70251838678;6687.598744075371;6732.831679207863;6862.691178897061;6954.617496037767;6660.966695166493;6670.7665231716655;6693;6700.195976482853;6720.260771315054;6557.868842623217;6623.403893649402;6682.231543372574;6686.030525573668;6763.391294783493;6438.169289272875;6467.256265529336;6561.278259391559;6569.671516424255;6590.7693230736695;6361.501174354179;6543.946849164599;6545.672716364258;6690.862553365842;6730.764423245163;6289.968550157403;6338.207724034496;6410.839729006812;6531.9020214695865;6536.673166341759 11:23:32 INFO - PID 3760 | |5;yui.html;907.8229745199686;913.1005959130259;923.1368670293276;929.9907000929988;935.0182308575994;19514.414567562977;20113.59772804543;20288.391348259574;20333.898330508364;20346;18604.813951860477;18632.72050919237;18713.625727485443;18783.718244226347;18874.811251887477;936.3492372800923;959.9712008639752;963.3593660215982;966.5215718219456;967.492066665003;951.6098399656142;959.0505399654362;962.5476026267643;962.7063745557602;965.7682156282477;1004.2919741582203;1005.3063386263491;1023.7645341571443;1057.1278695076553;1060.2207377577474;1029.4080903480453;1031.28841099641;1032.9483525823716;1034.2139973620065;1034.6378767431413;750.4746677325894;752.4356732450663;752.8419032003286;753.2128925273048;754.6792613139394;19775.505612359662;20030.79969200304;20761.688574671392;20833.270835520685;20897;21720.782792172035;22050.669239961415;22079.66880496794;22656.546869062528;22853.542929141324;17166;17188;17397.217125229396;17681.55796105095;18426.723599146022;3757.774533527997;3764.8117594120185;3765.190484045916;3770.3590389633555;3776.9433458498142;108932.4553377236;131809;144707.27646361807;147227;147832.26083869618;13439.193648381128;13866.791998120036;13971.301434928417;13975.580732578039;13992.650183745487;30006.849965750032;32385.838070809496;32435.51346729801;32574;32622.83688581542;8672.392932494791;8870.911290887138;8904.910950890408;8906.198442140238;8912.598933048028;4162.042730172077;4220.240356735817;4236.4704411948505;4244.72409293395;4246.8301267949555;5297.5232229099565;5305.336832895888;5363.088274993261;5393.325834270716;5399.838004859782;1054.7310435838813;1088.4122573810212;1097.1113398147368;1104.845321654969;1105.535675016479;686.2279935073043;692.51869950384;706.5725236232108;710.7121615745631;717.7595505505714;11897.643070707893;12014.879851201376;12253.448594813255;12366.62900112998;12533.37333133358;692.069166970424;698.1866125963196;701.0395757811831;705.5272967112047;721.3904250907974;5828.213191219216;5874.647521148745;5910.320313163955;5952.7023648817385;6088.817335479943;119548;119863;122910;123426;127489;103338.48330758448;105476.97968692963;105948.47025764977;107598.46200768946;109906.45046774874;99074;100592;102300.48849755703;103929;104156;12934.223946563236;12993.740125197632;13057;13199.93400033032;13380.330983450984;42777;43523.56476435195;43642.78178609087;43769.562304377825;44480.33279500875;59045.34295956778;60547.39452605417;77464.2253577457;80234;80673.19326806656;18679.626407472046;18932.337368192046;18983.715244271072;19420.805791942465;19815.108320125342;21231.893840530698;21635.459113522287;21657.350279491642;22149.446263843533;22637.2076977305;18996.145173467503;19827.40517784469;20023.199072036954;20462.693059604415;20679.27622533204;19677.606447871247;19812.228576556947;19824;20047;20335.69496457584;18703.06484675788;19369.90315048416;19398.806011940265;19538.21847126099;19671.60656786885;12139.817902731642;12363.258204507758;12817;12992.740145196854;13119.147255428366;14107.788383174466;14488;15123.546293611209;15162.696746065238;15324.157171355682 11:23:32 INFO - PID 3760 | __end_tp_report 11:23:32 INFO - PID 3760 | __start_cc_report 11:23:32 INFO - PID 3760 | _x_x_mozilla_cycle_collect,349 11:23:32 INFO - PID 3760 | __end_cc_report 11:23:32 INFO - PID 3760 | __startTimestamp1504808612929__endTimestamp 11:23:32 INFO - PID 3760 | 11:23:32 INFO - PID 3760 | ------- Summary: start ------- 11:23:32 INFO - PID 3760 | Number of tests: 6 11:23:32 INFO - PID 3760 | 11:23:32 INFO - PID 3760 | [#0] dojo.html Cycles:165 Average:6192.08 Median:6438.00 stddev:812.45 (12.6%) stddev-sans-first:781.23 11:23:32 INFO - PID 3760 | Values: 3239.4 3251.2 3258.2 3294.2 3318.3 6214.1 6333.0 6401.5 6438.0 6439.8 6203.9 6232.7 6262.7 6285.1 6288.3 5723.6 5745.1 5778.3 5915.1 5939.1 5806.6 5852.4 5872.0 5877.9 5926.6 1297.0 5674.9 5704.5 5851.0 5962.2 5624.1 5686.7 5779.3 5812.9 5864.3 5743.8 5789.8 5850.5 5851.4 5856.3 6295.9 6295.9 6335.3 6351.3 6416.6 6705.3 6717.7 6779.3 6793.8 6870.6 6845.6 6846.9 6906.8 6919.0 6934.5 6097.5 6173.5 6180.3 6192.4 6201.6 6873.1 6882.9 6895.4 6906.1 6990.4 6588.8 6695.1 6709.8 6713.7 6723.5 6671.5 6714.7 6834.0 6852.9 6856.5 6683.3 6722.1 6739.7 6816.5 6822.8 6489.7 6594.8 6736.3 6831.1 6865.1 5405.8 5407.5 5413.6 5422.0 5428.7 4665.5 4719.0 4780.5 4799.4 4811.9 5903.4 5918.3 5970.1 6003.3 6004.2 6564.8 6665.2 6729.4 6733.1 6927.9 5796.0 5805.2 5832.9 5856.4 5862.8 5779.4 5797.1 5859.1 5876.3 5893.1 6566.2 6602.0 6609.3 6625.5 6670.6 6734.7 6783.6 6835.5 6861.0 6872.5 6562.1 6562.9 6630.4 6658.7 6674.6 6499.4 6702.4 6710.6 6773.5 6821.9 6569.4 6709.5 6712.2 6725.2 6733.9 6490.5 6500.3 6512.4 6514.6 6542.8 6275.1 6440.3 6518.6 6591.6 6616.3 6309.5 6337.3 6350.4 6420.7 6426.1 6489.7 6520.6 6538.6 6566.8 6658.6 6258.6 6323.2 6379.1 6463.7 6492.2 11:23:32 INFO - PID 3760 | 11:23:32 INFO - PID 3760 | [#1] ext.html Cycles:180 Average:38424.84 Median:3550.80 stddev:56460.62 (1590.1%) stddev-sans-first:56548.47 11:23:32 INFO - PID 3760 | Values: 839.1 869.0 871.0 871.1 872.1 38823.0 42318.6 42739.0 42857.0 43065.6 39052.0 39310.0 39494.8 39765.6 39797.4 6958.0 6995.4 7005.4 7054.6 7073.6 6891.7 6972.9 6985.3 6993.6 7019.4 7034.1 7065.2 7726.3 7933.0 7945.3 7812.7 7887.4 7894.1 7896.2 7903.9 7623.5 7705.1 7714.7 7714.8 7775.2 38533.8 38570.4 39281.6 39346.6 39402.2 3544.8 3556.8 3584.6 3598.2 3615.6 32024.5 32109.2 32342.2 32346.7 32351.7 5102.6 5116.0 5116.8 5130.7 5137.0 221187.0 229202.0 229524.0 230006.0 230584.0 42609.8 43419.0 49396.8 49654.5 49884.3 52427.2 52548.7 52642.5 52714.0 52871.7 15896.4 15989.9 15992.1 16026.1 16029.3 13032.0 13074.5 13095.9 13103.8 13119.7 14295.2 14419.6 14424.1 14482.8 14706.1 5786.6 5788.7 5869.2 5929.4 5976.1 957.6 968.4 975.5 978.2 987.9 22179.4 22255.0 22390.0 22408.7 22998.0 1080.1 1083.4 1087.8 1088.6 1092.8 11824.6 11986.8 11996.2 11998.8 12035.5 228101.0 229112.0 229871.0 230173.0 231950.0 54277.0 54644.7 54917.5 54984.2 55119.2 1427.0 1464.7 1473.8 1487.1 1492.6 21842.0 21854.5 22011.6 22230.8 22611.4 34027.7 34266.7 34281.0 34306.0 34324.0 191429.0 192640.0 192840.0 193014.0 193743.0 30609.4 32936.0 33837.3 34662.5 34986.0 41283.4 43527.3 43772.8 44023.0 44052.0 31917.2 32130.8 32310.2 32352.5 32488.5 31979.0 32127.0 32165.0 32333.8 32825.2 35920.8 35933.0 35977.5 36123.5 36359.6 31553.2 31888.0 32157.0 33740.3 35074.8 24334.1 24907.0 24908.6 24943.0 25395.0 11:23:32 INFO - PID 3760 | 11:23:32 INFO - PID 3760 | [#2] jquery.html Cycles:180 Average:33552.99 Median:22748.93 stddev:75719.85 (332.9%) stddev-sans-first:75891.67 11:23:32 INFO - PID 3760 | Values: 533.8 553.3 567.6 580.1 595.3 21928.8 22787.3 22794.7 22885.1 22986.7 24094.4 24728.8 24741.4 24928.4 25152.4 6518.2 6701.2 6706.6 6711.3 6730.8 6604.2 6700.6 6727.2 6738.9 6744.8 6318.2 6636.7 6637.6 6652.7 6655.6 6583.5 6622.5 6626.2 6672.6 6674.2 5859.8 6058.3 6126.3 6162.8 6172.4 27671.2 27870.2 28119.0 28129.7 28206.3 2045.3 2067.9 2081.6 2084.1 2084.6 18504.2 18865.8 18947.0 19165.5 19190.5 2341.9 2406.9 2412.7 2416.1 2429.2 112015.0 119223.4 133884.3 138027.0 145645.3 14394.7 14439.4 14465.3 14582.6 14625.7 22627.5 22672.2 22694.3 22710.5 22825.8 9781.9 10148.9 10219.3 10235.8 10325.2 9460.4 9569.8 9675.5 9762.8 9806.3 8653.4 8794.9 8893.2 9129.3 9182.5 2582.1 2610.8 2684.8 2712.0 2760.7 919.0 951.7 958.5 961.9 971.0 19194.3 19197.1 19222.2 19303.0 19761.0 1005.3 1018.3 1021.3 1026.5 1038.8 10487.9 10527.5 10568.0 10580.0 10695.0 428148.0 435071.0 451629.0 454060.0 455552.0 116437.0 118413.4 120120.0 129399.0 135041.0 1178.6 1182.3 1245.8 1255.4 1263.8 20154.8 20887.4 20905.3 21286.0 21325.6 56419.4 59273.4 60506.4 60558.0 60933.4 70655.3 71595.9 71742.0 71884.0 72628.6 14356.4 14381.1 14391.1 14455.5 14542.2 22564.3 22645.7 22897.8 22947.2 23260.3 17764.8 18247.8 18421.4 18542.7 18579.6 16333.8 16348.3 16699.2 16959.2 16998.3 18446.8 18593.3 18766.5 18881.6 18885.0 13824.8 14167.6 14264.9 14435.0 14448.9 18112.2 18155.2 18164.4 18333.7 18497.4 11:23:32 INFO - PID 3760 | 11:23:32 INFO - PID 3760 | [#3] mootools.html Cycles:180 Average:9458.97 Median:26311.11 stddev:6654.65 (25.3%) stddev-sans-first:6645.31 11:23:32 INFO - PID 3760 | Values: 1332.6 1391.8 1394.3 1400.5 1402.4 15057.4 15505.4 15511.0 15588.7 15636.1 15397.4 15476.7 15564.5 15579.0 15613.5 2742.0 2789.8 2812.4 2819.2 2822.1 2631.9 2740.7 2758.9 2763.7 2786.2 2648.7 2768.0 2782.8 2784.4 2784.8 2783.7 2808.0 2836.0 2843.2 2851.2 2688.4 2688.6 2694.6 2695.4 2719.7 14785.6 15071.5 15095.5 15109.2 15116.5 7957.8 8212.0 8226.4 8238.2 8243.3 5462.3 5487.8 5556.6 5666.4 5670.1 1882.1 1905.6 1910.2 1931.5 1937.9 26016.5 26239.1 26245.0 26310.0 26312.2 7413.9 7432.6 7617.6 7669.0 7675.2 17040.2 17109.6 17255.4 17258.7 17295.7 7786.8 7851.0 7951.5 7960.6 8124.3 7251.5 7318.1 7321.7 7375.1 7397.3 5259.1 5364.9 5415.1 5423.6 5470.8 1320.7 1327.7 1531.3 1533.0 1553.5 726.7 875.5 879.6 884.1 890.0 8546.8 8665.7 8747.7 8764.6 8839.3 954.2 979.5 999.4 1003.9 1015.8 5400.2 5475.8 5627.0 5634.5 5657.6 21502.2 21777.5 22000.4 22028.2 22398.7 20525.5 20945.6 21410.1 21688.2 21694.5 11133.6 11488.3 11734.1 11737.8 11738.7 7935.4 8648.5 8737.8 8890.4 8916.6 18479.8 18652.6 19047.2 19149.5 19249.2 19012.0 19455.8 19504.8 19777.6 19877.9 9779.1 10350.8 10402.2 10403.6 10488.2 13624.1 13791.0 13796.8 13812.9 13820.0 11233.8 11373.7 11394.9 11585.7 11589.2 11163.3 11297.2 11396.4 11434.5 11654.4 10047.8 10082.0 10144.4 10174.2 10240.7 7402.9 7567.0 7633.1 7655.1 7777.8 7929.7 8004.7 8013.8 8016.3 8037.1 11:23:32 INFO - PID 3760 | 11:23:32 INFO - PID 3760 | [#4] prototype.html Cycles:180 Average:5617.17 Median:6292.59 stddev:1588.84 (25.2%) stddev-sans-first:1545.86 11:23:32 INFO - PID 3760 | Values: 482.8 514.7 518.1 520.0 520.3 6423.6 6434.6 6446.5 6488.4 6512.3 6277.0 6295.2 6378.5 6387.4 6413.3 4892.3 5128.5 5244.1 5245.9 5246.7 5000.8 5057.0 5067.0 5089.1 5100.2 4947.5 4983.9 4987.2 5008.2 5034.7 4966.3 5001.9 5004.2 5009.8 5110.4 4507.2 4515.9 4536.9 4547.5 4551.7 6198.3 6231.8 6253.8 6275.2 6332.1 5730.2 5757.9 5792.2 5832.8 5840.7 6676.2 6699.2 6714.6 6732.3 6768.4 4924.7 4944.4 4955.1 4960.4 4962.7 6742.4 6864.3 6933.0 6952.9 7052.8 5029.9 5039.1 5082.9 5093.3 5104.2 5060.7 5092.6 5110.5 5137.6 5183.0 5756.7 5780.2 5790.4 5803.8 5851.5 6725.7 6738.1 6759.9 6767.0 6796.6 1749.3 1762.3 1778.0 1782.4 1788.8 1174.2 1215.7 1231.3 1234.8 1257.4 5785.5 5840.5 5849.1 5854.4 5885.4 6646.6 6662.5 6789.7 6796.5 6874.3 5750.5 5801.2 5889.1 5906.8 5920.7 3561.9 3569.7 3637.6 3659.5 3670.5 6574.6 6675.6 6722.2 6767.5 6771.0 7051.2 7071.3 7083.0 7174.7 7180.9 6603.7 6642.9 6666.8 6703.8 6753.1 6794.0 6899.3 6929.5 6932.2 6972.2 6849.7 6855.5 6875.7 6913.6 6942.4 6708.5 6718.8 6729.0 6758.9 6760.9 4976.9 5029.2 5056.2 5067.7 5108.6 6610.7 6687.6 6732.8 6862.7 6954.6 6661.0 6670.8 6693.0 6700.2 6720.3 6557.9 6623.4 6682.2 6686.0 6763.4 6438.2 6467.3 6561.3 6569.7 6590.8 6361.5 6543.9 6545.7 6690.9 6730.8 6290.0 6338.2 6410.8 6531.9 6536.7 11:23:32 INFO - PID 3760 | 11:23:32 INFO - PID 3760 | [#5] yui.html Cycles:180 Average:25468.81 Median:20311.14 stddev:35615.56 (175.3%) stddev-sans-first:35667.72 11:23:32 INFO - PID 3760 | Values: 907.8 913.1 923.1 930.0 935.0 19514.4 20113.6 20288.4 20333.9 20346.0 18604.8 18632.7 18713.6 18783.7 18874.8 936.3 960.0 963.4 966.5 967.5 951.6 959.1 962.5 962.7 965.8 1004.3 1005.3 1023.8 1057.1 1060.2 1029.4 1031.3 1032.9 1034.2 1034.6 750.5 752.4 752.8 753.2 754.7 19775.5 20030.8 20761.7 20833.3 20897.0 21720.8 22050.7 22079.7 22656.5 22853.5 17166.0 17188.0 17397.2 17681.6 18426.7 3757.8 3764.8 3765.2 3770.4 3776.9 108932.5 131809.0 144707.3 147227.0 147832.3 13439.2 13866.8 13971.3 13975.6 13992.7 30006.8 32385.8 32435.5 32574.0 32622.8 8672.4 8870.9 8904.9 8906.2 8912.6 4162.0 4220.2 4236.5 4244.7 4246.8 5297.5 5305.3 5363.1 5393.3 5399.8 1054.7 1088.4 1097.1 1104.8 1105.5 686.2 692.5 706.6 710.7 717.8 11897.6 12014.9 12253.4 12366.6 12533.4 692.1 698.2 701.0 705.5 721.4 5828.2 5874.6 5910.3 5952.7 6088.8 119548.0 119863.0 122910.0 123426.0 127489.0 103338.5 105477.0 105948.5 107598.5 109906.5 99074.0 100592.0 102300.5 103929.0 104156.0 12934.2 12993.7 13057.0 13199.9 13380.3 42777.0 43523.6 43642.8 43769.6 44480.3 59045.3 60547.4 77464.2 80234.0 80673.2 18679.6 18932.3 18983.7 19420.8 19815.1 21231.9 21635.5 21657.4 22149.4 22637.2 18996.1 19827.4 20023.2 20462.7 20679.3 19677.6 19812.2 19824.0 20047.0 20335.7 18703.1 19369.9 19398.8 19538.2 19671.6 12139.8 12363.3 12817.0 12992.7 13119.1 14107.8 14488.0 15123.5 15162.7 15324.2 11:23:32 INFO - PID 3760 | -------- Summary: end -------- 11:23:32 INFO - PID 3760 | 11:23:33 INFO - TEST-INFO | 3760: exit 0 11:23:33 INFO - TEST-OK | dromaeo_css | took 1117307ms 11:23:33 INFO - TEST-START | kraken 11:23:33 INFO - Initialising browser for kraken test... 11:23:33 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:57086/getInfo.html -profile /tmp/tmpfkPriC/profile 11:23:33 INFO - TEST-INFO | started process 4151 (/builds/slave/test/build/application/firefox/firefox http://localhost:57086/getInfo.html) 11:23:40 INFO - TEST-INFO | 4151: exit 0 11:23:40 INFO - Browser initialized. 11:23:40 INFO - Running cycle 1/1 for kraken test... 11:23:40 INFO - Using env: {'DISPLAY': ':0', 11:23:40 INFO - 'HOME': '/home/cltbld', 11:23:40 INFO - 'JSGC_DISABLE_POISONING': '1', 11:23:40 INFO - 'LANG': 'en_US.UTF-8', 11:23:40 INFO - 'LANGUAGE': 'en_US:en', 11:23:40 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:23:40 INFO - 'LOGNAME': 'cltbld', 11:23:40 INFO - 'MAIL': '/var/mail/cltbld', 11:23:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:23:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:23:40 INFO - 'MOZ_ACCELERATED': '1', 11:23:40 INFO - 'MOZ_CRASHREPORTER': '1', 11:23:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:23:40 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:23:40 INFO - 'MOZ_NO_REMOTE': '1', 11:23:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:23:40 INFO - 'MOZ_WEBRENDER': '1', 11:23:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:23:40 INFO - 'NO_EM_RESTART': '1', 11:23:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:23:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:23:40 INFO - 'PWD': '/builds/slave/test', 11:23:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:23:40 INFO - 'RUST_BACKTRACE': 'full', 11:23:40 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:23:40 INFO - 'SHELL': '/bin/bash', 11:23:40 INFO - 'SHLVL': '1', 11:23:40 INFO - 'TERM': 'linux', 11:23:40 INFO - 'TMOUT': '86400', 11:23:40 INFO - 'USER': 'cltbld', 11:23:40 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1504807422.634008-1470331620', 11:23:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:23:40 INFO - '_': '/tools/buildbot/bin/python'} 11:23:40 INFO - TEST-INFO | started process 4359 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfkPriC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:23:41 INFO - PID 4359 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 11:23:41 INFO - PID 4359 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 11:23:41 INFO - PID 4359 | 11:23:41 INFO - PID 4359 | (/builds/slave/test/build/application/firefox/firefox:4420): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:23:41 INFO - PID 4359 | 11:23:51 INFO - PID 4359 | RSS: Main: 214204416 11:23:51 INFO - PID 4359 | 11:23:54 INFO - PID 4359 | Cycle 1(1): loaded http://localhost:57086/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57086/tests/kraken/driver.html?testName=audio-beat-detection) 11:23:55 INFO - PID 4359 | RSS: Main: 221069312 11:23:55 INFO - PID 4359 | 11:23:58 INFO - PID 4359 | Cycle 1(1): loaded http://localhost:57086/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57086/tests/kraken/driver.html?testName=audio-dft) 11:23:59 INFO - PID 4359 | RSS: Main: 222031872 11:23:59 INFO - PID 4359 | 11:24:02 INFO - PID 4359 | Cycle 1(1): loaded http://localhost:57086/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57086/tests/kraken/driver.html?testName=audio-fft) 11:24:02 INFO - PID 4359 | RSS: Main: 216129536 11:24:02 INFO - PID 4359 | 11:24:04 INFO - PID 4359 | Cycle 1(1): loaded http://localhost:57086/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57086/tests/kraken/driver.html?testName=audio-oscillator) 11:24:05 INFO - PID 4359 | RSS: Main: 217059328 11:24:05 INFO - PID 4359 | 11:24:07 INFO - PID 4359 | Cycle 1(1): loaded http://localhost:57086/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57086/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:24:08 INFO - PID 4359 | RSS: Main: 217739264 11:24:08 INFO - PID 4359 | 11:24:11 INFO - PID 4359 | Cycle 1(1): loaded http://localhost:57086/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57086/tests/kraken/driver.html?testName=imaging-darkroom) 11:24:12 INFO - PID 4359 | RSS: Main: 220246016 11:24:12 INFO - PID 4359 | 11:24:15 INFO - PID 4359 | Cycle 1(1): loaded http://localhost:57086/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57086/tests/kraken/driver.html?testName=imaging-desaturate) 11:24:16 INFO - PID 4359 | RSS: Main: 219779072 11:24:16 INFO - PID 4359 | 11:24:19 INFO - PID 4359 | Cycle 1(1): loaded http://localhost:57086/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57086/tests/kraken/driver.html?testName=json-parse-financial) 11:24:19 INFO - PID 4359 | RSS: Main: 219324416 11:24:19 INFO - PID 4359 | 11:24:21 INFO - PID 4359 | Cycle 1(1): loaded http://localhost:57086/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57086/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:24:22 INFO - PID 4359 | RSS: Main: 219963392 11:24:22 INFO - PID 4359 | 11:24:23 INFO - PID 4359 | Cycle 1(1): loaded http://localhost:57086/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57086/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:24:24 INFO - PID 4359 | RSS: Main: 220442624 11:24:24 INFO - PID 4359 | 11:24:26 INFO - PID 4359 | Cycle 1(1): loaded http://localhost:57086/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57086/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:24:27 INFO - PID 4359 | RSS: Main: 219942912 11:24:27 INFO - PID 4359 | 11:24:30 INFO - PID 4359 | Cycle 1(1): loaded http://localhost:57086/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57086/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:24:30 INFO - PID 4359 | RSS: Main: 221601792 11:24:30 INFO - PID 4359 | 11:24:33 INFO - PID 4359 | Cycle 1(1): loaded http://localhost:57086/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57086/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:24:34 INFO - PID 4359 | RSS: Main: 221106176 11:24:34 INFO - PID 4359 | 11:24:36 INFO - PID 4359 | Cycle 1(1): loaded http://localhost:57086/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57086/tests/kraken/driver.html?testName=ai-astar) 11:24:36 INFO - PID 4359 | RSS: Main: 223539200 11:24:36 INFO - PID 4359 | 11:24:36 INFO - PID 4359 | __start_tp_report 11:24:36 INFO - PID 4359 | _x_x_mozilla_page_load 11:24:36 INFO - PID 4359 | _x_x_mozilla_page_load_details 11:24:36 INFO - PID 4359 | |i|pagename|runs| 11:24:36 INFO - PID 4359 | |0;ai-astar;110;108;116;114;111;107;111;115;114;113 11:24:36 INFO - PID 4359 | |1;audio-beat-detection;121;122;121;123;126;119;125;122;157;121 11:24:36 INFO - PID 4359 | |2;audio-dft;177;163;174;164;167;171;163;165;170;167 11:24:36 INFO - PID 4359 | |3;audio-fft;80;79;77;83;82;85;75;74;80;85 11:24:36 INFO - PID 4359 | |4;audio-oscillator;89;86;79;83;80;80;81;78;86;79 11:24:36 INFO - PID 4359 | |5;imaging-gaussian-blur;114;116;113;114;117;114;115;121;116;115 11:24:36 INFO - PID 4359 | |6;imaging-darkroom;153;149;151;150;149;151;150;152;149;148 11:24:36 INFO - PID 4359 | |7;imaging-desaturate;94;97;94;101;94;95;94;95;95;95 11:24:36 INFO - PID 4359 | |8;json-parse-financial;60;53;54;54;53;52;53;53;53;51 11:24:36 INFO - PID 4359 | |9;json-stringify-tinderbox;38;38;39;41;39;48;40;40;40;38 11:24:36 INFO - PID 4359 | |10;stanford-crypto-aes;84;83;81;77;79;80;77;78;75;76 11:24:36 INFO - PID 4359 | |11;stanford-crypto-ccm;119;117;116;122;126;123;119;123;117;131 11:24:36 INFO - PID 4359 | |12;stanford-crypto-pbkdf2;171;179;173;172;168;171;172;185;179;170 11:24:36 INFO - PID 4359 | |13;stanford-crypto-sha256-iterative;65;65;62;63;64;72;64;67;65;66 11:24:36 INFO - PID 4359 | __end_tp_report 11:24:36 INFO - PID 4359 | __start_cc_report 11:24:36 INFO - PID 4359 | _x_x_mozilla_cycle_collect,924 11:24:36 INFO - PID 4359 | __end_cc_report 11:24:36 INFO - PID 4359 | __startTimestamp1504808676428__endTimestamp 11:24:36 INFO - PID 4359 | 11:24:36 INFO - PID 4359 | ------- Summary: start ------- 11:24:36 INFO - PID 4359 | Number of tests: 14 11:24:36 INFO - PID 4359 | 11:24:36 INFO - PID 4359 | [#0] ai-astar Cycles:10 Average:111.90 Median:113.50 stddev:3.00 (2.6%) stddev-sans-first:3.10 11:24:36 INFO - PID 4359 | Values: 110.0 108.0 116.0 114.0 111.0 107.0 111.0 115.0 114.0 113.0 11:24:36 INFO - PID 4359 | 11:24:36 INFO - PID 4359 | [#1] audio-beat-detection Cycles:10 Average:125.70 Median:122.50 stddev:11.19 (9.1%) stddev-sans-first:11.73 11:24:36 INFO - PID 4359 | Values: 121.0 122.0 121.0 123.0 126.0 119.0 125.0 122.0 157.0 121.0 11:24:36 INFO - PID 4359 | 11:24:36 INFO - PID 4359 | [#2] audio-dft Cycles:10 Average:168.10 Median:168.50 stddev:4.79 (2.8%) stddev-sans-first:3.86 11:24:36 INFO - PID 4359 | Values: 177.0 163.0 174.0 164.0 167.0 171.0 163.0 165.0 170.0 167.0 11:24:36 INFO - PID 4359 | 11:24:36 INFO - PID 4359 | [#3] audio-fft Cycles:10 Average:80.00 Median:81.00 stddev:3.86 (4.8%) stddev-sans-first:4.09 11:24:36 INFO - PID 4359 | Values: 80.0 79.0 77.0 83.0 82.0 85.0 75.0 74.0 80.0 85.0 11:24:36 INFO - PID 4359 | 11:24:36 INFO - PID 4359 | [#4] audio-oscillator Cycles:10 Average:82.10 Median:82.00 stddev:3.73 (4.5%) stddev-sans-first:3.00 11:24:36 INFO - PID 4359 | Values: 89.0 86.0 79.0 83.0 80.0 80.0 81.0 78.0 86.0 79.0 11:24:36 INFO - PID 4359 | 11:24:36 INFO - PID 4359 | [#5] imaging-gaussian-blur Cycles:10 Average:115.50 Median:115.50 stddev:2.27 (2.0%) stddev-sans-first:2.35 11:24:36 INFO - PID 4359 | Values: 114.0 116.0 113.0 114.0 117.0 114.0 115.0 121.0 116.0 115.0 11:24:36 INFO - PID 4359 | 11:24:36 INFO - PID 4359 | [#6] imaging-darkroom Cycles:10 Average:150.20 Median:150.50 stddev:1.55 (1.0%) stddev-sans-first:1.27 11:24:36 INFO - PID 4359 | Values: 153.0 149.0 151.0 150.0 149.0 151.0 150.0 152.0 149.0 148.0 11:24:36 INFO - PID 4359 | 11:24:36 INFO - PID 4359 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.00 stddev:2.17 (2.3%) stddev-sans-first:2.24 11:24:36 INFO - PID 4359 | Values: 94.0 97.0 94.0 101.0 94.0 95.0 94.0 95.0 95.0 95.0 11:24:36 INFO - PID 4359 | 11:24:36 INFO - PID 4359 | [#8] json-parse-financial Cycles:10 Average:53.60 Median:53.00 stddev:2.41 (4.6%) stddev-sans-first:0.93 11:24:36 INFO - PID 4359 | Values: 60.0 53.0 54.0 54.0 53.0 52.0 53.0 53.0 53.0 51.0 11:24:36 INFO - PID 4359 | 11:24:36 INFO - PID 4359 | [#9] json-stringify-tinderbox Cycles:10 Average:40.10 Median:40.00 stddev:2.96 (7.4%) stddev-sans-first:3.04 11:24:36 INFO - PID 4359 | Values: 38.0 38.0 39.0 41.0 39.0 48.0 40.0 40.0 40.0 38.0 11:24:36 INFO - PID 4359 | 11:24:36 INFO - PID 4359 | [#10] stanford-crypto-aes Cycles:10 Average:79.00 Median:79.50 stddev:2.98 (3.8%) stddev-sans-first:2.55 11:24:36 INFO - PID 4359 | Values: 84.0 83.0 81.0 77.0 79.0 80.0 77.0 78.0 75.0 76.0 11:24:36 INFO - PID 4359 | 11:24:36 INFO - PID 4359 | [#11] stanford-crypto-ccm Cycles:10 Average:121.30 Median:122.50 stddev:4.69 (3.8%) stddev-sans-first:4.90 11:24:36 INFO - PID 4359 | Values: 119.0 117.0 116.0 122.0 126.0 123.0 119.0 123.0 117.0 131.0 11:24:36 INFO - PID 4359 | 11:24:36 INFO - PID 4359 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.00 Median:172.50 stddev:5.27 (3.1%) stddev-sans-first:5.48 11:24:36 INFO - PID 4359 | Values: 171.0 179.0 173.0 172.0 168.0 171.0 172.0 185.0 179.0 170.0 11:24:36 INFO - PID 4359 | 11:24:36 INFO - PID 4359 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.30 Median:65.00 stddev:2.75 (4.2%) stddev-sans-first:2.92 11:24:36 INFO - PID 4359 | Values: 65.0 65.0 62.0 63.0 64.0 72.0 64.0 67.0 65.0 66.0 11:24:36 INFO - PID 4359 | -------- Summary: end -------- 11:24:36 INFO - PID 4359 | 11:24:36 INFO - PID 4359 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:24:37 INFO - TEST-INFO | 4359: exit 0 11:24:37 INFO - TEST-OK | kraken | took 63520ms 11:24:37 INFO - SUITE-END | took 1180s 11:24:37 INFO - Completed test suite (00:19:40) 11:24:37 INFO - javascript benchmark 11:24:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8629.419658070548, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3239.4007108684896, 3251.2359595495063, 3258.185453636591, 3294.176455886027, 3318.2865683877976, 6214.06788981653, 6332.9683351583235, 6401.51988600855, 6438.002109673002, 6439.839004024901, 6203.875922481548, 6232.719527621257, 6262.686865656722, 6285.088662143987, 6288.276848162463, 5723.627964182325, 5745.080787074069, 5778.335491418477, 5915.142304365864, 5939.109133629969, 5806.59353845231, 5852.385499522531, 5871.970640146793, 5877.853053673671, 5926.555508336871, 1296.9607220619555, 5674.943250567483, 5704.515116215127, 5851.0, 5962.1951036609935, 5624.100143976944, 5686.658800471943, 5779.335376431723, 5812.941870581282, 5864.266966629171, 5743.770249190027, 5789.755202631412, 5850.502707269845, 5851.444112809277, 5856.32652244993, 6295.937040629581, 6295.937040629581, 6335.334789847046, 6351.269603995554, 6416.647084410356, 6705.295943925867, 6717.664116794141, 6779.305906825732, 6793.762218322335, 6870.5534140281225, 6845.589264644137, 6846.931530684729, 6906.792796216121, 6919.031335613018, 6934.549254298455, 6097.451229389376, 6173.506119510428, 6180.2892667343385, 6192.411720886508, 6201.565890387675, 6873.1064961554675, 6882.8967565486555, 6895.448364130857, 6906.06768086312, 6990.370866622028, 6588.8023359299295, 6695.062691223233, 6709.832254193684, 6713.664316784141, 6723.462123030145, 6671.532992690562, 6714.664266786641, 6834.0, 6852.903535434307, 6856.485763567753, 6683.2648408675, 6722.092517510074, 6739.696713647898, 6816.4546836252985, 6822.761203357859, 6489.70796314167, 6594.802155935329, 6736.292689267654, 6831.11195544576, 6865.107536020385, 5405.7837686492885, 5407.513323800877, 5413.566914646819, 5422.024035673617, 5428.728563571805, 4665.533446655375, 4718.976405117953, 4780.545848144421, 4799.3760811095035, 4811.927821082687, 5903.439173278532, 5918.348981612019, 5970.13433052205, 6003.309619393738, 6004.219451471281, 6564.770233041821, 6665.166854143232, 6729.427998620172, 6733.124693789776, 6927.861442771116, 5796.0, 5805.245318108618, 5832.941670583325, 5856.443637854397, 5862.824115276549, 5779.3642699303045, 5797.072468405119, 5859.121131830259, 5876.324222714443, 5893.057110862242, 6566.24488183865, 6602.0, 6609.272979972199, 6625.503087268377, 6670.599764014175, 6734.730610775514, 6783.626900520519, 6835.487338449537, 6861.0, 6872.450203983769, 6562.146920900253, 6562.934370656232, 6630.370114839083, 6658.700358483977, 6674.632895190811, 6499.38255865692, 6702.430293425114, 6710.63091529951, 6773.525853190229, 6821.93178068213, 6569.441597464269, 6709.530332876652, 6712.160979877515, 6725.226598941184, 6733.898991515033, 6490.513211509061, 6500.284968653539, 6512.446442052478, 6514.609123452418, 6542.803715888531, 6275.121482992294, 6440.32376600469, 6518.608883467007, 6591.571547849375, 6616.338366163345, 6309.49524038085, 6337.334579869047, 6350.364963503613, 6420.7431702731365, 6426.132472116392, 6489.675516224075, 6520.576162549419, 6538.607683539003, 6566.770163044271, 6658.600483970978, 6258.561900666909, 6323.177986861862, 6379.106925030592, 6463.741450341934, 6492.220933487823], "value": 6136.0966989603385, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [839.1356902390538, 869.0223498564116, 870.9564521773909, 871.1462766488838, 872.149654087265, 38823.0, 42318.57681423185, 42739.0, 42857.0, 43065.56934430655, 39052.0, 39310.0, 39494.80252598733, 39765.60234397655, 39797.40303895437, 6957.965210173942, 6995.370416662499, 7005.439564834826, 7054.576725396492, 7073.646317684121, 6891.689873955659, 6972.860542789142, 6985.336393042653, 6993.615351155684, 7019.368256856882, 7034.05040319558, 7065.2228254891925, 7726.304632583066, 7932.960335198316, 7945.324647404977, 7812.726554570591, 7887.408444366695, 7894.052713674396, 7896.170902055316, 7903.881441778378, 7623.542587444771, 7705.113911900091, 7714.729984450573, 7714.765637497973, 7775.222477752236, 38533.80733096345, 38570.421443678366, 39281.60718392837, 39346.60653393458, 39402.21195576072, 3544.769589976643, 3556.8399422025814, 3584.551931008624, 3598.208394153282, 3615.6384361563896, 32024.519632205534, 32109.197270068435, 32342.191445213823, 32346.6765332346, 32351.6764832351, 5102.6428150029515, 5115.974420127913, 5116.795328186868, 5130.71781052042, 5136.974315128437, 221187.0, 229202.0, 229524.0, 230006.0, 230583.9999999983, 42609.78695106567, 43419.0, 49396.75301623469, 49654.503454964986, 49884.25173622399, 52427.21359179616, 52548.73725631347, 52642.47357526452, 52714.0, 52871.735641321546, 15896.364145434285, 15989.920050399674, 15992.120433376276, 16026.118563478887, 16029.278682459317, 13031.957443404504, 13074.542391016268, 13095.886849617698, 13103.803442948363, 13119.737605247841, 14295.213763242913, 14419.63950901215, 14424.134551926918, 14482.782758258634, 14706.117632942058, 5786.566007549451, 5788.710564471759, 5869.178315035899, 5929.37741537141, 5976.073708575178, 957.5882370580578, 968.3560432312574, 975.4781192062354, 978.188103873783, 987.9407235565889, 22179.44551386196, 22255.0, 22390.0, 22408.66387004196, 22998.0, 1080.103514083309, 1083.4041277297456, 1087.798757229915, 1088.5754555723274, 1092.759592889563, 11824.586139485076, 11986.760264794655, 11996.160268781101, 11998.820017699742, 12035.518579256906, 228101.0, 229112.0, 229871.0, 230173.0, 231950.0, 54277.0, 54644.72677636586, 54917.45082549203, 54984.17523737147, 55119.173212401845, 1426.9500567480295, 1464.699736554025, 1473.7715654073636, 1487.0631502153574, 1492.5895378770708, 21842.0, 21854.45363865916, 22011.559768804855, 22230.77769222287, 22611.43471413228, 34027.65972340245, 34266.657333426345, 34281.0, 34306.0, 34324.0, 191429.0, 192640.0, 192840.0, 193014.0, 193743.0, 30609.387812243185, 32936.0, 33837.32325353529, 34662.48006279958, 34986.0, 41283.38074928938, 43527.34708979431, 43772.78113609411, 44023.0, 44052.0, 31917.20206994844, 32130.83934580312, 32310.192245193117, 32352.514712278862, 32488.51267230946, 31979.0, 32127.0, 32165.0, 32333.838330809136, 32825.17937051593, 35920.820395897856, 35933.0, 35977.460338094425, 36123.458148127276, 36359.63640363669, 31553.21116972094, 31888.0, 32157.03528894137, 33740.325193495504, 35074.82462587773, 24334.148304809245, 24907.0, 24908.62637060409, 24942.95365544987, 25395.0], "value": 17118.64373091062, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [533.7571405010721, 553.3442870198817, 567.5828266224322, 580.1442871764148, 595.3153873045998, 21928.780712192874, 22787.31638050857, 22794.65808012879, 22885.084596616114, 22986.65520017199, 24094.397640058964, 24728.75271247287, 24741.38146546337, 24928.376790580245, 25152.37119072024, 6518.185226846633, 6701.195856497227, 6706.564073335242, 6711.261761206288, 6730.764423245188, 6604.207495100594, 6700.597964122144, 6727.226368967558, 6738.898916516257, 6744.7976560703255, 6318.210223722035, 6636.668166591675, 6637.634930078843, 6652.733890644368, 6655.633940133291, 6583.5062370322175, 6622.503312251576, 6626.204855417381, 6672.633005184713, 6674.16572928384, 5859.794907178229, 6058.273007239115, 6126.326104128542, 6162.815115546541, 6172.4136207060255, 27671.169864903884, 27870.16389508318, 28119.0158344459, 28129.718702812916, 28206.294842628893, 2045.263705066175, 2067.8966051697357, 2081.6044951459176, 2084.135083940163, 2084.5622419291817, 18504.167312470836, 18865.811341886543, 18947.0, 19165.520861978563, 19190.520236994187, 2341.94145146371, 2406.9037238510437, 2412.6984126984125, 2416.1422694943217, 2429.2226487524, 112015.0, 119223.4038829809, 133884.33057834746, 138027.0, 145645.27177364152, 14394.712105758035, 14439.422423103168, 14465.27673616315, 14582.562523124323, 14625.6725748729, 22627.547449050926, 22672.206472773374, 22694.319170424915, 22710.545789084124, 22825.771742282366, 9781.85327220078, 10148.898511014942, 10219.284650074424, 10235.846462303072, 10325.225608079425, 9460.385074970105, 9569.760755981157, 9675.5486676999, 9762.75593110178, 9806.264530160266, 8653.394262401698, 8794.86807697885, 8893.155150260714, 9129.269658427309, 9182.494962777111, 2582.138545501738, 2610.8172427930244, 2684.8120631555994, 2711.972880271172, 2760.6963234044238, 918.963241470347, 951.743029382063, 958.5399008475971, 961.8701475300885, 970.9563069661741, 19194.328198513263, 19197.136128874234, 19222.231110755412, 19303.0, 19761.0, 1005.2661557063238, 1018.332991890313, 1021.3463383434607, 1026.4764969865273, 1038.787048655024, 10487.895121048845, 10527.526261318259, 10568.0, 10579.978351199357, 10695.0, 428148.0, 435071.0, 451629.0, 454060.0, 455552.0, 116437.0, 118413.4079329615, 120120.0, 129399.0, 135041.0, 1178.5933852820763, 1182.3319824299244, 1245.781988152088, 1255.3534929511309, 1263.7977923532374, 20154.798452015293, 20887.37337879866, 20905.268315608882, 21286.0, 21325.573488529833, 56419.43580564142, 59273.40726592679, 60506.39493605184, 60558.0, 60933.39066609454, 70655.29344706693, 71595.92606110808, 71742.0, 71884.0, 72628.63685681538, 14356.35396407185, 14381.137131772128, 14391.064580802215, 14455.49405770793, 14542.200178990257, 22564.323070307917, 22645.660315095618, 22897.771022289562, 22947.196848110238, 23260.3021909343, 17764.822351776318, 18247.81752182461, 18421.447356579323, 18542.721859172394, 18579.628407432047, 16333.836661633706, 16348.264328105026, 16699.24853381625, 16959.23683434273, 16998.320067197667, 18446.815531845048, 18593.256269749058, 18766.53083672919, 18881.622367552296, 18885.0, 13824.792628110385, 14167.64580885486, 14264.928675356558, 14435.0, 14448.927755361156, 18112.18495167747, 18155.183016764015, 18164.364247251284, 18333.724994124834, 18497.352592659194], "value": 11936.052651810545, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1332.6335257804103, 1391.7634002219622, 1394.2610416479263, 1400.4958215042584, 1402.3549167383003, 15057.397704091823, 15505.379784808594, 15510.991785533932, 15588.688226235468, 15636.140012299333, 15397.384104635801, 15476.690466190697, 15564.533064008097, 15579.0, 15613.453529126482, 2741.986290068547, 2789.7768178545716, 2812.409394027257, 2819.1824370932404, 2822.0969289827162, 2631.868406579673, 2740.7122252163535, 2758.8620568971573, 2763.6545431821023, 2786.192004318755, 2648.655674762278, 2767.9723202767914, 2782.819116757404, 2784.4431113777223, 2784.763295119917, 2783.6520434945633, 2808.0312292259136, 2835.9858200709073, 2843.1896909380935, 2851.2016635342034, 2688.3951111000065, 2688.6101515280175, 2694.5688689809535, 2695.43395886864, 2719.728027197284, 14785.55643330691, 15071.547853564301, 15095.4716584919, 15109.244537773067, 15116.470923517734, 7957.7612671619945, 8212.0, 8226.383021273428, 8238.217369349963, 8243.299319557846, 5462.289902312714, 5487.75305111271, 5556.611037227396, 5666.376698563155, 5670.149477578355, 1882.1342182596022, 1905.6093500832435, 1910.2263583248807, 1931.5267759398896, 1937.903104844752, 26016.479670406487, 26239.081632142974, 26245.0, 26310.0, 26312.21063368102, 7413.925860741431, 7432.554046757212, 7617.619119044026, 7669.0, 7675.15573286938, 17040.233189506253, 17109.572260693334, 17255.3960611378, 17258.654826903392, 17295.65408691819, 7786.7663970080985, 7851.0, 7951.483153594998, 7960.601969901481, 8124.309433698202, 7251.4923955323675, 7318.085239345082, 7321.743738969217, 7375.11498620169, 7397.334239918433, 5259.0804356409635, 5364.946350536445, 5415.1335786274, 5423.593230507728, 5470.781168753205, 1320.7226482438602, 1327.707904261061, 1531.2649928034605, 1533.0495093042161, 1553.4640549010574, 726.7093162734948, 875.4572165257581, 879.6481407437076, 884.0540621534896, 889.9644014239358, 8546.829063418696, 8665.653373865101, 8747.693830715894, 8764.649414023495, 8839.29285657146, 954.2175416158683, 979.4515071559949, 999.3654029691053, 1003.8745156855393, 1015.827309357411, 5400.162974738922, 5475.780968761205, 5627.0, 5634.549236061105, 5657.632253903483, 21502.247421340177, 21777.455563610718, 22000.44998875041, 22028.229011984502, 22398.664020039712, 20525.48686282825, 20945.58108837815, 21410.143594256057, 21688.240911568337, 21694.45763855916, 11133.554657813758, 11488.310701357945, 11734.11994100446, 11737.765244695229, 11738.70653233676, 7935.444518883623, 8648.481091134552, 8737.825243494968, 8890.377673562789, 8916.55417229149, 18479.81520184781, 18652.626947461245, 19047.238110475424, 19149.521261968563, 19249.23003079917, 19012.0, 19455.8054419454, 19504.8049519503, 19777.604447910675, 19877.900610496854, 9779.119879210904, 10350.792984140426, 10402.219833512669, 10403.635872744419, 10488.213383996079, 13624.114432561852, 13791.0, 13796.793048104488, 13812.86187138156, 13820.032597718064, 11233.831492527455, 11373.658790236306, 11394.886051139383, 11585.7103572408, 11589.188756787282, 11163.330200188015, 11297.15271354668, 11396.430178491208, 11434.542618295507, 11654.417279136178, 10047.849282260626, 10082.04220599042, 10144.391336519537, 10174.186065114922, 10240.692779216635, 7402.925970740439, 7567.0, 7633.122190948112, 7655.0813902332075, 7777.805554860947, 7929.682812687428, 8004.719834805754, 8013.759587212393, 8016.318612917734, 8037.075736290401], "value": 6786.447713338308, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [482.833422469248, 514.7323391836245, 518.085578953148, 520.0431206579892, 520.2950002746279, 6423.554700192454, 6434.646094464802, 6446.548741588091, 6488.416042556169, 6512.348765123491, 6277.0, 6295.213098362705, 6378.521610879179, 6387.393197646228, 6413.326600706917, 4892.266160075999, 5128.461461561516, 5244.134717771563, 5245.8950820983555, 5246.7407822122605, 5000.824971126011, 5057.0, 5066.97466512667, 5089.109405853979, 5100.234964755298, 4947.505249475042, 4983.9252411213865, 4987.226979818116, 5008.198688209887, 5034.672746271499, 4966.25506174075, 5001.949980500185, 5004.249362595603, 5009.799608015675, 5110.361204849394, 4507.219648238927, 4515.932261016087, 4536.8638940831825, 4547.522510136454, 4551.704139230939, 6198.349173336825, 6231.813045608639, 6253.781117660906, 6275.246970363585, 6332.145160403379, 5730.169125476783, 5757.913631295534, 5792.189093526909, 5832.795852145197, 5840.737166827503, 6676.198856137246, 6699.229588597276, 6714.563553369064, 6732.326767323278, 6768.39084482394, 4924.655274130812, 4944.381952255968, 4955.1080805455, 4960.379952505937, 4962.727050012248, 6742.359475849787, 6864.318242030685, 6933.0, 6952.930470695279, 7052.753153639598, 5029.874253143701, 5039.118154322979, 5082.898342033212, 5093.286939828427, 5104.2343648453025, 5060.746962651852, 5092.643514953992, 5110.463401342806, 5137.640365174402, 5182.97408512955, 5756.65460072397, 5780.16187652788, 5790.36306006339, 5803.767849285981, 5851.502622277069, 6725.66371681414, 6738.056672065914, 6759.932400676029, 6766.966165169241, 6796.558223715443, 1749.3177660712333, 1762.2510433065895, 1778.0398584764082, 1782.4028950301536, 1788.7585176001332, 1174.2308787744041, 1215.6535387414544, 1231.335079057317, 1234.7839128152536, 1257.440439004634, 5785.479306862402, 5840.503557197686, 5849.064149736107, 5854.356020837705, 5885.3820348862755, 6646.601203927683, 6662.533622646465, 6789.72841086351, 6796.490263230277, 6874.312568743086, 5750.511206547407, 5801.158831969341, 5889.146073819272, 5906.7637294508595, 5920.733566989496, 3561.878008427337, 3569.696575791035, 3637.618050104754, 3659.524261845943, 3670.541182352206, 6574.572652777554, 6675.599464032077, 6722.159730033746, 6767.52627316093, 6771.002554246411, 7051.1891132519395, 7071.292870712888, 7082.964585177041, 7174.748883789042, 7180.8922866157045, 6603.712276106113, 6642.933570664231, 6666.799996000031, 6703.798886033427, 6753.1220941277315, 6793.966030170015, 6899.310068993061, 6929.514933954575, 6932.227109156176, 6972.163340399185, 6849.726010959505, 6855.520113592001, 6875.690593923386, 6913.5506192097355, 6942.409895158968, 6708.463322934056, 6718.757029949475, 6728.966355168192, 6758.86482270342, 6760.93239067603, 4976.850694479172, 5029.170186919117, 5056.165732654218, 5067.670601410897, 5108.61685373591, 6610.70251838678, 6687.598744075371, 6732.831679207863, 6862.691178897061, 6954.617496037767, 6660.966695166493, 6670.7665231716655, 6693.0, 6700.195976482853, 6720.260771315054, 6557.868842623217, 6623.403893649402, 6682.231543372574, 6686.030525573668, 6763.391294783493, 6438.169289272875, 6467.256265529336, 6561.278259391559, 6569.671516424255, 6590.7693230736695, 6361.501174354179, 6543.946849164599, 6545.672716364258, 6690.862553365842, 6730.764423245163, 6289.968550157403, 6338.207724034496, 6410.839729006812, 6531.9020214695865, 6536.673166341759], "value": 5145.205546269518, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [907.8229745199686, 913.1005959130259, 923.1368670293276, 929.9907000929988, 935.0182308575994, 19514.414567562977, 20113.59772804543, 20288.391348259574, 20333.898330508364, 20346.0, 18604.813951860477, 18632.72050919237, 18713.625727485443, 18783.718244226347, 18874.811251887477, 936.3492372800923, 959.9712008639752, 963.3593660215982, 966.5215718219456, 967.492066665003, 951.6098399656142, 959.0505399654362, 962.5476026267643, 962.7063745557602, 965.7682156282477, 1004.2919741582203, 1005.3063386263491, 1023.7645341571443, 1057.1278695076553, 1060.2207377577474, 1029.4080903480453, 1031.28841099641, 1032.9483525823716, 1034.2139973620065, 1034.6378767431413, 750.4746677325894, 752.4356732450663, 752.8419032003286, 753.2128925273048, 754.6792613139394, 19775.505612359662, 20030.79969200304, 20761.688574671392, 20833.270835520685, 20897.0, 21720.782792172035, 22050.669239961415, 22079.66880496794, 22656.546869062528, 22853.542929141324, 17166.0, 17188.0, 17397.217125229396, 17681.55796105095, 18426.723599146022, 3757.774533527997, 3764.8117594120185, 3765.190484045916, 3770.3590389633555, 3776.9433458498142, 108932.4553377236, 131809.0, 144707.27646361807, 147227.0, 147832.26083869618, 13439.193648381128, 13866.791998120036, 13971.301434928417, 13975.580732578039, 13992.650183745487, 30006.849965750032, 32385.838070809496, 32435.51346729801, 32574.0, 32622.83688581542, 8672.392932494791, 8870.911290887138, 8904.910950890408, 8906.198442140238, 8912.598933048028, 4162.042730172077, 4220.240356735817, 4236.4704411948505, 4244.72409293395, 4246.8301267949555, 5297.5232229099565, 5305.336832895888, 5363.088274993261, 5393.325834270716, 5399.838004859782, 1054.7310435838813, 1088.4122573810212, 1097.1113398147368, 1104.845321654969, 1105.535675016479, 686.2279935073043, 692.51869950384, 706.5725236232108, 710.7121615745631, 717.7595505505714, 11897.643070707893, 12014.879851201376, 12253.448594813255, 12366.62900112998, 12533.37333133358, 692.069166970424, 698.1866125963196, 701.0395757811831, 705.5272967112047, 721.3904250907974, 5828.213191219216, 5874.647521148745, 5910.320313163955, 5952.7023648817385, 6088.817335479943, 119548.0, 119863.0, 122910.0, 123426.0, 127489.0, 103338.48330758448, 105476.97968692963, 105948.47025764977, 107598.46200768946, 109906.45046774874, 99074.0, 100592.0, 102300.48849755703, 103929.0, 104156.0, 12934.223946563236, 12993.740125197632, 13057.0, 13199.93400033032, 13380.330983450984, 42777.0, 43523.56476435195, 43642.78178609087, 43769.562304377825, 44480.33279500875, 59045.34295956778, 60547.39452605417, 77464.2253577457, 80234.0, 80673.19326806656, 18679.626407472046, 18932.337368192046, 18983.715244271072, 19420.805791942465, 19815.108320125342, 21231.893840530698, 21635.459113522287, 21657.350279491642, 22149.446263843533, 22637.2076977305, 18996.145173467503, 19827.40517784469, 20023.199072036954, 20462.693059604415, 20679.27622533204, 19677.606447871247, 19812.228576556947, 19824.0, 20047.0, 20335.69496457584, 18703.06484675788, 19369.90315048416, 19398.806011940265, 19538.21847126099, 19671.60656786885, 12139.817902731642, 12363.258204507758, 12817.0, 12992.740145196854, 13119.147255428366, 14107.788383174466, 14488.0, 15123.546293611209, 15162.696746065238, 15324.157171355682], "value": 9431.852861315023, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1462.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 108.0, 116.0, 114.0, 111.0, 107.0, 111.0, 115.0, 114.0, 113.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 122.0, 121.0, 123.0, 126.0, 119.0, 125.0, 122.0, 157.0, 121.0], "value": 125.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 163.0, 174.0, 164.0, 167.0, 171.0, 163.0, 165.0, 170.0, 167.0], "value": 168.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 77.0, 83.0, 82.0, 85.0, 75.0, 74.0, 80.0, 85.0], "value": 80.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 79.0, 83.0, 80.0, 80.0, 81.0, 78.0, 86.0, 79.0], "value": 82.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 116.0, 113.0, 114.0, 117.0, 114.0, 115.0, 121.0, 116.0, 115.0], "value": 115.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 149.0, 151.0, 150.0, 149.0, 151.0, 150.0, 152.0, 149.0, 148.0], "value": 150.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 97.0, 94.0, 101.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 53.0, 54.0, 54.0, 53.0, 52.0, 53.0, 53.0, 53.0, 51.0], "value": 53.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 39.0, 41.0, 39.0, 48.0, 40.0, 40.0, 40.0, 38.0], "value": 40.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 81.0, 77.0, 79.0, 80.0, 77.0, 78.0, 75.0, 76.0], "value": 79.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 117.0, 116.0, 122.0, 126.0, 123.0, 119.0, 123.0, 117.0, 131.0], "value": 121.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 179.0, 173.0, 172.0, 168.0, 171.0, 172.0, 185.0, 179.0, 170.0], "value": 174.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 62.0, 63.0, 64.0, 72.0, 64.0, 67.0, 65.0, 66.0], "value": 65.3, "unit": "score"}]}]} 11:24:37 INFO - Return code: 0 11:24:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:24:37 INFO - # TBPL SUCCESS # 11:24:37 INFO - Running post-action listener: _package_coverage_data 11:24:37 INFO - Running post-action listener: _resource_record_post_action 11:24:37 INFO - [mozharness: 2017-09-07 18:24:37.707100Z] Finished run-tests step (success) 11:24:37 INFO - Running post-run listener: _resource_record_post_run 11:24:37 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 16953344; Write bytes: 402489344; Read time: 8004; Write time: 237348 11:24:37 INFO - TinderboxPrint: CPU usage
13.3% 11:24:37 INFO - TinderboxPrint: I/O read bytes / time
16,953,344 / 8,004 11:24:37 INFO - TinderboxPrint: I/O write bytes / time
402,489,344 / 237,348 11:24:37 INFO - TinderboxPrint: CPU idle
8,275.7 (86.7%) 11:24:37 INFO - TinderboxPrint: CPU user
1,203.2 (12.6%) 11:24:37 INFO - TinderboxPrint: Swap in / out
0 / 0 11:24:37 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 116862976; Read time: 0; Write time: 69564 11:24:37 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:24:37 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 15208448; Write bytes: 285626368; Read time: 7936; Write time: 167784 11:24:38 INFO - Running post-run listener: _upload_blobber_files 11:24:38 INFO - Blob upload gear active. 11:24:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:24:38 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:24:38 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:24:38 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:24:38 INFO - (blobuploader) - INFO - Open directory for files ... 11:24:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:24:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:24:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:24:39 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:24:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:24:39 INFO - (blobuploader) - INFO - Done attempting. 11:24:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:24:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:24:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:24:43 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:24:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:24:43 INFO - (blobuploader) - INFO - Done attempting. 11:24:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:24:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:24:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:24:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:24:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:24:44 INFO - (blobuploader) - INFO - Done attempting. 11:24:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:24:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:24:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:24:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:24:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:24:45 INFO - (blobuploader) - INFO - Done attempting. 11:24:45 INFO - (blobuploader) - INFO - Iteration through files over. 11:24:45 INFO - Return code: 0 11:24:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:24:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:24:45 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b6f7d2d0223ac4bf37b8565b66637abfd2d3d970178e83e43d8d45f0024be8aab01be3df69a131f1786a2f8297dc7360981f38e84bea62808af2bd37664fd148", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3ef132e15571e321b1828f8616e90776176fb5d83849d181547006fef1ae0801bbceb9bcb65470005f01692d510f550317fb428c9a7ac67c1368deca03f2f6ed", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d1e6a40d395df6c9cb0de66b8456a28d56f155ec999864ab3a9bbca485b5b8e162fff7ccab36ad1619d604f7251fd3c28dc08076e1affec6029a6bf4bb45cdb8", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/378a220ea875b22fc92fda8b588cf1372250ccd3b1783aa6f3c36b7465cf6d924dcaed9bced823aec74f2626af01ffb1e5c79fe8a4ca5d7f3bbcc840810a419e"} 11:24:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:24:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:24:45 INFO - Contents: 11:24:45 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b6f7d2d0223ac4bf37b8565b66637abfd2d3d970178e83e43d8d45f0024be8aab01be3df69a131f1786a2f8297dc7360981f38e84bea62808af2bd37664fd148", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3ef132e15571e321b1828f8616e90776176fb5d83849d181547006fef1ae0801bbceb9bcb65470005f01692d510f550317fb428c9a7ac67c1368deca03f2f6ed", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d1e6a40d395df6c9cb0de66b8456a28d56f155ec999864ab3a9bbca485b5b8e162fff7ccab36ad1619d604f7251fd3c28dc08076e1affec6029a6bf4bb45cdb8", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/378a220ea875b22fc92fda8b588cf1372250ccd3b1783aa6f3c36b7465cf6d924dcaed9bced823aec74f2626af01ffb1e5c79fe8a4ca5d7f3bbcc840810a419e"} 11:24:45 INFO - Running post-run listener: copy_logs_to_upload_dir 11:24:45 INFO - Copying logs to upload dir... 11:24:45 INFO - mkdir: /builds/slave/test/build/upload/logs 11:24:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.310082 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-09-07 11:24:45.251866) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-07 11:24:45.255307) ========= 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=0e2a256762fed810e2f0f810000001b3-1504807422.634008-1470331620 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/b6f7d2d0223ac4bf37b8565b66637abfd2d3d970178e83e43d8d45f0024be8aab01be3df69a131f1786a2f8297dc7360981f38e84bea62808af2bd37664fd148", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3ef132e15571e321b1828f8616e90776176fb5d83849d181547006fef1ae0801bbceb9bcb65470005f01692d510f550317fb428c9a7ac67c1368deca03f2f6ed", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d1e6a40d395df6c9cb0de66b8456a28d56f155ec999864ab3a9bbca485b5b8e162fff7ccab36ad1619d604f7251fd3c28dc08076e1affec6029a6bf4bb45cdb8", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/378a220ea875b22fc92fda8b588cf1372250ccd3b1783aa6f3c36b7465cf6d924dcaed9bced823aec74f2626af01ffb1e5c79fe8a4ca5d7f3bbcc840810a419e"} build_url:https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011344 build_url: 'https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b6f7d2d0223ac4bf37b8565b66637abfd2d3d970178e83e43d8d45f0024be8aab01be3df69a131f1786a2f8297dc7360981f38e84bea62808af2bd37664fd148", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3ef132e15571e321b1828f8616e90776176fb5d83849d181547006fef1ae0801bbceb9bcb65470005f01692d510f550317fb428c9a7ac67c1368deca03f2f6ed", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d1e6a40d395df6c9cb0de66b8456a28d56f155ec999864ab3a9bbca485b5b8e162fff7ccab36ad1619d604f7251fd3c28dc08076e1affec6029a6bf4bb45cdb8", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/378a220ea875b22fc92fda8b588cf1372250ccd3b1783aa6f3c36b7465cf6d924dcaed9bced823aec74f2626af01ffb1e5c79fe8a4ca5d7f3bbcc840810a419e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-07 11:24:45.284675) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 11:24:45.285018) ========= 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=0e2a256762fed810e2f0f810000001b3-1504807422.634008-1470331620 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004471 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 11:24:45.369972) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-07 11:24:45.370304) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-07 11:24:45.370626) ========= ========= Total master_lag: 0.22 =========