builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-084 starttime: 1505298028.68 results: success (0) revision: 9873269746359dbcccbd5b44f0e82c0225289945 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-13 03:20:28.675702) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-13 03:20:28.676049) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-13 03:20:28.676329) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-13 03:20:28.741948) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 03:20:28.742203) ========= 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=ea65d483da93c827905c2090000001f5-1505290513.130544-8439048 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-13 03:20:28-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.4M=0s 2017-09-13 03:20:28 (46.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.177683 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 03:20:28.988173) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 03:20:28.988442) ========= 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=ea65d483da93c827905c2090000001f5-1505290513.130544-8439048 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018839 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 03:20:29.045505) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 03:20:29.045794) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 9873269746359dbcccbd5b44f0e82c0225289945 --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 9873269746359dbcccbd5b44f0e82c0225289945 --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=ea65d483da93c827905c2090000001f5-1505290513.130544-8439048 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-13 03:20:29,095 truncating revision to first 12 chars 2017-09-13 03:20:29,095 Setting DEBUG logging. 2017-09-13 03:20:29,095 attempt 1/10 2017-09-13 03:20:29,095 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/987326974635?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-13 03:20:29,363 unpacking tar archive at: mozilla-central-987326974635/testing/mozharness/ program finished with exit code 0 elapsedTime=0.591378 ========= master_lag: 0.12 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 03:20:29.756372) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-13 03:20:29.756632) ========= script_repo_revision: 9873269746359dbcccbd5b44f0e82c0225289945 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-13 03:20:29.756955) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-13 03:20:29.757221) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-13 03:20:29.796404) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2017-09-13 03:20:29.796650) ========= /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=ea65d483da93c827905c2090000001f5-1505290513.130544-8439048 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:20:29 INFO - MultiFileLogger online at 20170913 03:20:29 in /builds/slave/test 03:20:29 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 03:20:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:20:29 INFO - {'append_to_log': False, 03:20:29 INFO - 'base_work_dir': '/builds/slave/test', 03:20:29 INFO - 'blob_upload_branch': 'Firefox', 03:20:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:20:29 INFO - 'branch': 'Firefox', 03:20:29 INFO - 'buildbot_json_path': 'buildprops.json', 03:20:29 INFO - 'code_coverage': False, 03:20:29 INFO - 'config_files': ('talos/linux_config.py',), 03:20:29 INFO - 'default_actions': ('clobber', 03:20:29 INFO - 'read-buildbot-config', 03:20:29 INFO - 'download-and-extract', 03:20:29 INFO - 'populate-webroot', 03:20:29 INFO - 'create-virtualenv', 03:20:29 INFO - 'install', 03:20:29 INFO - 'setup-mitmproxy', 03:20:29 INFO - 'run-tests'), 03:20:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:20:29 INFO - 'disable_ccov_upload': False, 03:20:29 INFO - 'disable_stylo': False, 03:20:29 INFO - 'download_minidump_stackwalk': True, 03:20:29 INFO - 'download_symbols': 'ondemand', 03:20:29 INFO - 'enable_stylo': False, 03:20:29 INFO - 'enable_webrender': False, 03:20:29 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 03:20:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:20:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:20:29 INFO - 'gecko_profile': False, 03:20:29 INFO - 'gecko_profile_interval': 0, 03:20:29 INFO - 'installer_path': 'installer.exe', 03:20:29 INFO - 'log_level': 'info', 03:20:29 INFO - 'log_name': 'talos', 03:20:29 INFO - 'log_to_console': True, 03:20:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:20:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:20:29 INFO - 'opt_config_files': (), 03:20:29 INFO - 'pip_index': False, 03:20:29 INFO - 'suite': 'dromaeojs-e10s', 03:20:29 INFO - 'system_bits': '32', 03:20:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:20:29 INFO - 'title': 'talos-linux64-ix-084', 03:20:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:20:29 INFO - 'use_talos_json': True, 03:20:29 INFO - 'verify': 'False', 03:20:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:20:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:20:29 INFO - 'work_dir': 'build'} 03:20:29 INFO - [mozharness: 2017-09-13 10:20:29.989986Z] Running clobber step. 03:20:29 INFO - Running pre-action listener: _resource_record_pre_action 03:20:29 INFO - Running main action method: clobber 03:20:29 INFO - rmtree: /builds/slave/test/build 03:20:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:20:31 INFO - Running post-action listener: _resource_record_post_action 03:20:31 INFO - [mozharness: 2017-09-13 10:20:31.523872Z] Finished clobber step (success) 03:20:31 INFO - [mozharness: 2017-09-13 10:20:31.523970Z] Running read-buildbot-config step. 03:20:31 INFO - Running pre-action listener: _resource_record_pre_action 03:20:31 INFO - Running main action method: read_buildbot_config 03:20:31 INFO - Using buildbot properties: 03:20:31 INFO - { 03:20:31 INFO - "project": "", 03:20:31 INFO - "product": "firefox", 03:20:31 INFO - "who": "archaeopteryx@coole-files.de", 03:20:31 INFO - "installer_path": "public/build/target.tar.bz2", 03:20:31 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 03:20:31 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:20:31 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 03:20:31 INFO - "stage_platform": "linux64-qr", 03:20:31 INFO - "basedir": "/builds/slave/test", 03:20:31 INFO - "buildnumber": 49, 03:20:31 INFO - "platform": "ubuntu64_hw_qr", 03:20:31 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:20:31 INFO - "slavebuilddir": "test", 03:20:31 INFO - "taskId": "Uh7nRG2xSFGIzwew0F7OQQ", 03:20:31 INFO - "branch": "mozilla-central", 03:20:31 INFO - "script_repo_revision": "production", 03:20:31 INFO - "revision": "9873269746359dbcccbd5b44f0e82c0225289945", 03:20:31 INFO - "slavename": "talos-linux64-ix-084", 03:20:31 INFO - "repo_path": "mozilla-central" 03:20:31 INFO - } 03:20:31 INFO - Finding installer, test and symbols from parent task. 03:20:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Uh7nRG2xSFGIzwew0F7OQQ'}, attempt #1 03:20:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Uh7nRG2xSFGIzwew0F7OQQ'}, attempt #1 03:20:32 INFO - Task dependencies: TFFNhlJXQAqdPaYDbVW9jw 03:20:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TFFNhlJXQAqdPaYDbVW9jw'}, attempt #1 03:20:32 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/TFFNhlJXQAqdPaYDbVW9jw/artifacts/public/build/target.tar.bz2 03:20:32 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/TFFNhlJXQAqdPaYDbVW9jw/artifacts/public/build/target.test_packages.json 03:20:32 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/TFFNhlJXQAqdPaYDbVW9jw/artifacts/public/build/target.crashreporter-symbols.zip 03:20:32 INFO - Running post-action listener: _resource_record_post_action 03:20:32 INFO - [mozharness: 2017-09-13 10:20:32.837261Z] Finished read-buildbot-config step (success) 03:20:32 INFO - [mozharness: 2017-09-13 10:20:32.837480Z] Running download-and-extract step. 03:20:32 INFO - Running pre-action listener: _resource_record_pre_action 03:20:32 INFO - Running main action method: download_and_extract 03:20:32 INFO - mkdir: /builds/slave/test/build/tests 03:20:32 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')]} 03:20:32 INFO - trying https://queue.taskcluster.net/v1/task/TFFNhlJXQAqdPaYDbVW9jw/artifacts/public/build/target.test_packages.json 03:20:32 INFO - Downloading https://queue.taskcluster.net/v1/task/TFFNhlJXQAqdPaYDbVW9jw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:20:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TFFNhlJXQAqdPaYDbVW9jw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:20:33 INFO - Downloaded 989 bytes. 03:20:33 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:20:33 INFO - Using the following test package requirements: 03:20:33 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:20:33 INFO - u'common': [u'target.common.tests.zip'], 03:20:33 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:20:33 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:20:33 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:20:33 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:20:33 INFO - u'mozbase': [u'target.common.tests.zip'], 03:20:33 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:20:33 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:20:33 INFO - u'web-platform': [u'target.common.tests.zip', 03:20:33 INFO - u'target.web-platform.tests.tar.gz'], 03:20:33 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:20:33 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 03:20:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TFFNhlJXQAqdPaYDbVW9jw/artifacts/public/build/target.common.tests.zip 03:20:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TFFNhlJXQAqdPaYDbVW9jw/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:20:33 INFO - Fetch https://queue.taskcluster.net/v1/task/TFFNhlJXQAqdPaYDbVW9jw/artifacts/public/build/target.common.tests.zip into memory 03:20:36 INFO - Content-Length response header: 54557149 03:20:36 INFO - Bytes received: 54557149 03:20:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TFFNhlJXQAqdPaYDbVW9jw/artifacts/public/build/target.talos.tests.zip 03:20:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TFFNhlJXQAqdPaYDbVW9jw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:20:47 INFO - Fetch https://queue.taskcluster.net/v1/task/TFFNhlJXQAqdPaYDbVW9jw/artifacts/public/build/target.talos.tests.zip into memory 03:20:48 INFO - Content-Length response header: 14499226 03:20:48 INFO - Bytes received: 14499226 03:20:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:48 INFO - trying https://queue.taskcluster.net/v1/task/TFFNhlJXQAqdPaYDbVW9jw/artifacts/public/build/target.tar.bz2 03:20:48 INFO - Downloading https://queue.taskcluster.net/v1/task/TFFNhlJXQAqdPaYDbVW9jw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:20:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TFFNhlJXQAqdPaYDbVW9jw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:20:52 INFO - Downloaded 61556491 bytes. 03:20:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TFFNhlJXQAqdPaYDbVW9jw/artifacts/public/build/target.tar.bz2 03:20:52 INFO - mkdir: /builds/slave/test/properties 03:20:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:20:52 INFO - Writing to file /builds/slave/test/properties/build_url 03:20:52 INFO - Contents: 03:20:52 INFO - build_url:https://queue.taskcluster.net/v1/task/TFFNhlJXQAqdPaYDbVW9jw/artifacts/public/build/target.tar.bz2 03:20:52 INFO - Running post-action listener: _resource_record_post_action 03:20:52 INFO - Running post-action listener: find_tests_for_verification 03:20:52 INFO - Running post-action listener: set_extra_try_arguments 03:20:52 INFO - [mozharness: 2017-09-13 10:20:52.566023Z] Finished download-and-extract step (success) 03:20:52 INFO - [mozharness: 2017-09-13 10:20:52.566181Z] Running populate-webroot step. 03:20:52 INFO - Running pre-action listener: _resource_record_pre_action 03:20:52 INFO - Running main action method: populate_webroot 03:20:52 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:20:52 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:20:52 INFO - 'tests': ['tresize', 03:20:52 INFO - 'tcanvasmark']}, 03:20:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:20:52 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:20:52 INFO - 'tests': ['dromaeo_css', 03:20:52 INFO - 'kraken']}, 03:20:52 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:20:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:20:52 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:20:52 INFO - 'talos_options': ['--disable-stylo'], 03:20:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:20:52 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:20:52 INFO - 'tests': ['damp', 'tps']}, 03:20:52 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:20:52 INFO - 'talos_options': ['--disable-stylo'], 03:20:52 INFO - 'tests': ['damp', 'tps']}, 03:20:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:20:52 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:20:52 INFO - 'tests': ['dromaeo_dom']}, 03:20:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:20:52 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:20:52 INFO - 'tests': ['basic_compositor_video', 03:20:52 INFO - 'glvideo']}, 03:20:52 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:20:52 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:20:52 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:20:52 INFO - 'talos_options': ['--disable-stylo'], 03:20:52 INFO - 'tests': ['ts_paint_webext', 03:20:52 INFO - 'tp5o_webext']}, 03:20:52 INFO - 'other-e10s': {'tests': ['a11yr', 03:20:52 INFO - 'ts_paint', 03:20:52 INFO - 'tpaint', 03:20:52 INFO - 'sessionrestore', 03:20:52 INFO - 'sessionrestore_many_windows', 03:20:52 INFO - 'sessionrestore_no_auto_restore', 03:20:52 INFO - 'tabpaint']}, 03:20:52 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:20:52 INFO - 'tests': ['a11yr', 03:20:52 INFO - 'ts_paint', 03:20:52 INFO - 'tpaint', 03:20:52 INFO - 'sessionrestore', 03:20:52 INFO - 'sessionrestore_many_windows', 03:20:52 INFO - 'sessionrestore_no_auto_restore', 03:20:52 INFO - 'tabpaint']}, 03:20:52 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:20:52 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 03:20:52 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:20:52 INFO - 'tests': ['bloom_basic_singleton']}, 03:20:52 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:20:52 INFO - 'tests': ['bloom_basic']}, 03:20:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:20:52 INFO - 'tsvgr_opacity', 03:20:52 INFO - 'tart', 03:20:52 INFO - 'tscrollx', 03:20:52 INFO - 'tsvg_static']}, 03:20:52 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:20:52 INFO - 'tests': ['tsvgx', 03:20:52 INFO - 'tsvgr_opacity', 03:20:52 INFO - 'tart', 03:20:52 INFO - 'tscrollx', 03:20:52 INFO - 'tsvg_static']}, 03:20:52 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:20:52 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:20:52 INFO - 'talos_options': ['--disable-stylo'], 03:20:52 INFO - 'tests': ['tp5o']}, 03:20:52 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:20:52 INFO - 'talos_options': ['--mitmproxy', 03:20:52 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:20:52 INFO - '--firstNonBlankPaint'], 03:20:52 INFO - 'tests': ['tp6_google', 03:20:52 INFO - 'tp6_youtube', 03:20:52 INFO - 'tp6_amazon', 03:20:52 INFO - 'tp6_facebook']}, 03:20:52 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:20:52 INFO - 'talos_options': ['--disable-stylo', 03:20:52 INFO - '--mitmproxy', 03:20:52 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:20:52 INFO - '--firstNonBlankPaint'], 03:20:52 INFO - 'tests': ['tp6_google', 03:20:52 INFO - 'tp6_youtube', 03:20:52 INFO - 'tp6_amazon', 03:20:52 INFO - 'tp6_facebook']}, 03:20:52 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:20:52 INFO - 'talos_options': ['--stylo-threads=1', 03:20:52 INFO - '--mitmproxy', 03:20:52 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:20:52 INFO - '--firstNonBlankPaint'], 03:20:52 INFO - 'tests': ['tp6_google', 03:20:52 INFO - 'tp6_youtube', 03:20:52 INFO - 'tp6_amazon', 03:20:52 INFO - 'tp6_facebook']}, 03:20:52 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:20:52 INFO - 'talos_options': ['--xperf_path', 03:20:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:20:52 INFO - 'tests': ['tp5n']}, 03:20:52 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:20:52 INFO - 'talos_options': ['--disable-stylo', 03:20:52 INFO - '--xperf_path', 03:20:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:20:52 INFO - 'tests': ['tp5n']}}} 03:20:52 INFO - Running post-action listener: _resource_record_post_action 03:20:52 INFO - [mozharness: 2017-09-13 10:20:52.583494Z] Finished populate-webroot step (success) 03:20:52 INFO - [mozharness: 2017-09-13 10:20:52.583591Z] Running create-virtualenv step. 03:20:52 INFO - Running pre-action listener: _resource_record_pre_action 03:20:52 INFO - Running main action method: create_virtualenv 03:20:52 INFO - Creating virtualenv /builds/slave/test/build/venv 03:20:52 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:20:52 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 03:20:52 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:20:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:20:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:20:53 INFO - Installing distribute.............................................................................................................................................................................................done. 03:20:53 INFO - Installing pip...............done. 03:20:53 INFO - Return code: 0 03:20:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:20:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:20:53 INFO - Reading from file tmpfile_stdout 03:20:53 INFO - Output received: 03:20:53 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 03:20:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:20:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x270fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2713090>, '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 0x2713d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x270df90>, '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': 'ea65d483da93c827905c2090000001f5-1505290513.130544-8439048', '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 03:20:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:20:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:20:53 INFO - Using env: {'DISPLAY': ':0', 03:20:53 INFO - 'HOME': '/home/cltbld', 03:20:53 INFO - 'LANG': 'en_US.UTF-8', 03:20:53 INFO - 'LANGUAGE': 'en_US:en', 03:20:53 INFO - 'LOGNAME': 'cltbld', 03:20:53 INFO - 'MAIL': '/var/mail/cltbld', 03:20:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:53 INFO - 'MOZ_NO_REMOTE': '1', 03:20:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:53 INFO - 'NO_EM_RESTART': '1', 03:20:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:53 INFO - 'PWD': '/builds/slave/test', 03:20:53 INFO - 'SHELL': '/bin/bash', 03:20:53 INFO - 'SHLVL': '1', 03:20:53 INFO - 'TERM': 'linux', 03:20:53 INFO - 'TMOUT': '86400', 03:20:53 INFO - 'USER': 'cltbld', 03:20:53 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1505290513.130544-8439048', 03:20:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:53 INFO - '_': '/tools/buildbot/bin/python'} 03:20:54 INFO - Ignoring indexes: http://pypi.python.org/simple/ 03:20:54 INFO - Downloading/unpacking pip>=1.5 03:20:54 INFO - Running setup.py egg_info for package pip 03:20:54 INFO - warning: no files found matching 'pip/cacert.pem' 03:20:54 INFO - warning: no files found matching '*.html' under directory 'docs' 03:20:54 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:20:54 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:20:54 INFO - Installing collected packages: pip 03:20:54 INFO - Found existing installation: pip 1.1 03:20:54 INFO - Uninstalling pip: 03:20:54 INFO - Successfully uninstalled pip 03:20:54 INFO - Running setup.py install for pip 03:20:54 INFO - warning: no files found matching 'pip/cacert.pem' 03:20:54 INFO - warning: no files found matching '*.html' under directory 'docs' 03:20:54 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:20:54 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:20:54 INFO - Installing pip script to /builds/slave/test/build/venv/bin 03:20:54 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 03:20:54 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 03:20:54 INFO - Successfully installed pip 03:20:54 INFO - Cleaning up... 03:20:54 INFO - Return code: 0 03:20:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:20:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x270fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2713090>, '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 0x2713d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x270df90>, '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': 'ea65d483da93c827905c2090000001f5-1505290513.130544-8439048', '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 03:20:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:20:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:20:54 INFO - Using env: {'DISPLAY': ':0', 03:20:54 INFO - 'HOME': '/home/cltbld', 03:20:54 INFO - 'LANG': 'en_US.UTF-8', 03:20:54 INFO - 'LANGUAGE': 'en_US:en', 03:20:54 INFO - 'LOGNAME': 'cltbld', 03:20:54 INFO - 'MAIL': '/var/mail/cltbld', 03:20:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:54 INFO - 'MOZ_NO_REMOTE': '1', 03:20:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:54 INFO - 'NO_EM_RESTART': '1', 03:20:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:54 INFO - 'PWD': '/builds/slave/test', 03:20:54 INFO - 'SHELL': '/bin/bash', 03:20:54 INFO - 'SHLVL': '1', 03:20:54 INFO - 'TERM': 'linux', 03:20:54 INFO - 'TMOUT': '86400', 03:20:54 INFO - 'USER': 'cltbld', 03:20:54 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1505290513.130544-8439048', 03:20:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:54 INFO - '_': '/tools/buildbot/bin/python'} 03:20:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:54 INFO - Downloading/unpacking psutil>=3.1.1 03:20:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:20:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:20:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:20:56 INFO - Installing collected packages: psutil 03:20:56 INFO - Running setup.py install for psutil 03:20:56 INFO - building 'psutil._psutil_linux' extension 03:20:56 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 03:20:56 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 03:20:56 INFO - building 'psutil._psutil_posix' extension 03:20:56 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 03:20:56 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 03:20:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:20:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:20:56 INFO - Successfully installed psutil 03:20:56 INFO - Cleaning up... 03:20:56 INFO - Return code: 0 03:20:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:20: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')]} 03:20:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20: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')]} 03:20:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:56 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 0x23a31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x270fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2713090>, '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 0x2713d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x270df90>, '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': 'ea65d483da93c827905c2090000001f5-1505290513.130544-8439048', '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 03:20:56 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 03:20:56 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 03:20:56 INFO - Using env: {'DISPLAY': ':0', 03:20:56 INFO - 'HOME': '/home/cltbld', 03:20:56 INFO - 'LANG': 'en_US.UTF-8', 03:20:56 INFO - 'LANGUAGE': 'en_US:en', 03:20:56 INFO - 'LOGNAME': 'cltbld', 03:20:56 INFO - 'MAIL': '/var/mail/cltbld', 03:20:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:56 INFO - 'MOZ_NO_REMOTE': '1', 03:20:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:56 INFO - 'NO_EM_RESTART': '1', 03:20:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:56 INFO - 'PWD': '/builds/slave/test', 03:20:56 INFO - 'SHELL': '/bin/bash', 03:20:56 INFO - 'SHLVL': '1', 03:20:56 INFO - 'TERM': 'linux', 03:20:56 INFO - 'TMOUT': '86400', 03:20:56 INFO - 'USER': 'cltbld', 03:20:56 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1505290513.130544-8439048', 03:20:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:56 INFO - '_': '/tools/buildbot/bin/python'} 03:20:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:20:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:20:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:20:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:20:58 INFO - Installing collected packages: mozsystemmonitor 03:20:58 INFO - Running setup.py install for mozsystemmonitor 03:20:58 INFO - Successfully installed mozsystemmonitor 03:20:58 INFO - Cleaning up... 03:20:59 INFO - Return code: 0 03:20:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:20:59 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')]} 03:20:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:59 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')]} 03:20:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:59 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 0x23a31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x270fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2713090>, '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 0x2713d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x270df90>, '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': 'ea65d483da93c827905c2090000001f5-1505290513.130544-8439048', '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 03:20:59 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 03:20:59 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 03:20:59 INFO - Using env: {'DISPLAY': ':0', 03:20:59 INFO - 'HOME': '/home/cltbld', 03:20:59 INFO - 'LANG': 'en_US.UTF-8', 03:20:59 INFO - 'LANGUAGE': 'en_US:en', 03:20:59 INFO - 'LOGNAME': 'cltbld', 03:20:59 INFO - 'MAIL': '/var/mail/cltbld', 03:20:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:59 INFO - 'MOZ_NO_REMOTE': '1', 03:20:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:59 INFO - 'NO_EM_RESTART': '1', 03:20:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:59 INFO - 'PWD': '/builds/slave/test', 03:20:59 INFO - 'SHELL': '/bin/bash', 03:20:59 INFO - 'SHLVL': '1', 03:20:59 INFO - 'TERM': 'linux', 03:20:59 INFO - 'TMOUT': '86400', 03:20:59 INFO - 'USER': 'cltbld', 03:20:59 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1505290513.130544-8439048', 03:20:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:59 INFO - '_': '/tools/buildbot/bin/python'} 03:20:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:59 INFO - Downloading/unpacking jsonschema==2.5.1 03:20:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:21:00 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:21:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:00 INFO - Downloading functools32-3.2.3-2.tar.gz 03:21:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:21:00 INFO - warning: no files found matching '*.txt' 03:21:00 INFO - no previously-included directories found matching 'build' 03:21:00 INFO - no previously-included directories found matching 'dist' 03:21:00 INFO - no previously-included directories found matching '.git*' 03:21:00 INFO - Installing collected packages: jsonschema, functools32 03:21:01 INFO - Running setup.py install for functools32 03:21:01 INFO - warning: no files found matching '*.txt' 03:21:01 INFO - no previously-included directories found matching 'build' 03:21:01 INFO - no previously-included directories found matching 'dist' 03:21:01 INFO - no previously-included directories found matching '.git*' 03:21:01 INFO - Successfully installed jsonschema functools32 03:21:01 INFO - Cleaning up... 03:21:01 INFO - Return code: 0 03:21:01 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:21:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x23a31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x270fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2713090>, '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 0x2713d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x270df90>, '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': 'ea65d483da93c827905c2090000001f5-1505290513.130544-8439048', '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 03:21:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:21:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:21:01 INFO - Using env: {'DISPLAY': ':0', 03:21:01 INFO - 'HOME': '/home/cltbld', 03:21:01 INFO - 'LANG': 'en_US.UTF-8', 03:21:01 INFO - 'LANGUAGE': 'en_US:en', 03:21:01 INFO - 'LOGNAME': 'cltbld', 03:21:01 INFO - 'MAIL': '/var/mail/cltbld', 03:21:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:01 INFO - 'MOZ_NO_REMOTE': '1', 03:21:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:21:01 INFO - 'NO_EM_RESTART': '1', 03:21:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:21:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:01 INFO - 'PWD': '/builds/slave/test', 03:21:01 INFO - 'SHELL': '/bin/bash', 03:21:01 INFO - 'SHLVL': '1', 03:21:01 INFO - 'TERM': 'linux', 03:21:01 INFO - 'TMOUT': '86400', 03:21:01 INFO - 'USER': 'cltbld', 03:21:01 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1505290513.130544-8439048', 03:21:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:01 INFO - '_': '/tools/buildbot/bin/python'} 03:21:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:21:02 INFO - Cleaning up... 03:21:02 INFO - Return code: 0 03:21:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:21:02 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')]} 03:21:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:02 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')]} 03:21:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:02 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 0x23a31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x270fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2713090>, '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 0x2713d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x270df90>, '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': 'ea65d483da93c827905c2090000001f5-1505290513.130544-8439048', '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 03:21:02 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 03:21:02 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 03:21:02 INFO - Using env: {'DISPLAY': ':0', 03:21:02 INFO - 'HOME': '/home/cltbld', 03:21:02 INFO - 'LANG': 'en_US.UTF-8', 03:21:02 INFO - 'LANGUAGE': 'en_US:en', 03:21:02 INFO - 'LOGNAME': 'cltbld', 03:21:02 INFO - 'MAIL': '/var/mail/cltbld', 03:21:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:02 INFO - 'MOZ_NO_REMOTE': '1', 03:21:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:21:02 INFO - 'NO_EM_RESTART': '1', 03:21:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:21:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:02 INFO - 'PWD': '/builds/slave/test', 03:21:02 INFO - 'SHELL': '/bin/bash', 03:21:02 INFO - 'SHLVL': '1', 03:21:02 INFO - 'TERM': 'linux', 03:21:02 INFO - 'TMOUT': '86400', 03:21:02 INFO - 'USER': 'cltbld', 03:21:02 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1505290513.130544-8439048', 03:21:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:02 INFO - '_': '/tools/buildbot/bin/python'} 03:21:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:02 INFO - Downloading/unpacking blobuploader==1.2.4 03:21:02 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 03:21:02 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 03:21:02 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 03:21:02 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 03:21:03 INFO - Downloading blobuploader-1.2.4.tar.gz 03:21:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:21:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:21:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:21:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:21:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:03 INFO - Downloading docopt-0.6.1.tar.gz 03:21:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:21:04 INFO - Installing collected packages: blobuploader, requests, docopt 03:21:04 INFO - Running setup.py install for blobuploader 03:21:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:21:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:21:04 INFO - Running setup.py install for requests 03:21:04 INFO - Running setup.py install for docopt 03:21:04 INFO - Successfully installed blobuploader requests docopt 03:21:04 INFO - Cleaning up... 03:21:04 INFO - Return code: 0 03:21:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:21:04 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')]} 03:21:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:04 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')]} 03:21:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:04 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 0x23a31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x270fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2713090>, '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 0x2713d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x270df90>, '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': 'ea65d483da93c827905c2090000001f5-1505290513.130544-8439048', '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 03:21:04 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 03:21:04 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 03:21:04 INFO - Using env: {'DISPLAY': ':0', 03:21:04 INFO - 'HOME': '/home/cltbld', 03:21:04 INFO - 'LANG': 'en_US.UTF-8', 03:21:04 INFO - 'LANGUAGE': 'en_US:en', 03:21:04 INFO - 'LOGNAME': 'cltbld', 03:21:04 INFO - 'MAIL': '/var/mail/cltbld', 03:21:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:04 INFO - 'MOZ_NO_REMOTE': '1', 03:21:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:21:04 INFO - 'NO_EM_RESTART': '1', 03:21:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:21:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:04 INFO - 'PWD': '/builds/slave/test', 03:21:04 INFO - 'SHELL': '/bin/bash', 03:21:04 INFO - 'SHLVL': '1', 03:21:04 INFO - 'TERM': 'linux', 03:21:04 INFO - 'TMOUT': '86400', 03:21:04 INFO - 'USER': 'cltbld', 03:21:04 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1505290513.130544-8439048', 03:21:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:04 INFO - '_': '/tools/buildbot/bin/python'} 03:21:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:21:04 INFO - Running setup.py (path:/tmp/pip-sEX6xZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:21:04 INFO - Running setup.py (path:/tmp/pip-RbXlvR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:21:05 INFO - Running setup.py (path:/tmp/pip-LokSch-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:21:05 INFO - Running setup.py (path:/tmp/pip-95p0wu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:21:05 INFO - Running setup.py (path:/tmp/pip-3x14Fb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:21:05 INFO - Running setup.py (path:/tmp/pip-tmCA7k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:21:05 INFO - Running setup.py (path:/tmp/pip-qJqI7s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:21:05 INFO - Running setup.py (path:/tmp/pip-BW_B0K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:21:05 INFO - Running setup.py (path:/tmp/pip-1ltBIf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:21:05 INFO - Running setup.py (path:/tmp/pip-WgTgSC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:21:05 INFO - Running setup.py (path:/tmp/pip-pBO5uk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:21:05 INFO - Running setup.py (path:/tmp/pip-S01xQ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:21:05 INFO - Running setup.py (path:/tmp/pip-Vx3IIC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:21:05 INFO - Running setup.py (path:/tmp/pip-ux00gG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:21:05 INFO - Running setup.py (path:/tmp/pip-UZ7_5S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:21:05 INFO - Running setup.py (path:/tmp/pip-bkgxDl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:21:05 INFO - Running setup.py (path:/tmp/pip-Kduq7G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:21:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:21:06 INFO - Running setup.py install for manifestparser 03:21:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:21:06 INFO - Running setup.py install for mozcrash 03:21:06 INFO - Running setup.py install for mozdebug 03:21:06 INFO - Running setup.py install for mozdevice 03:21:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:21:06 INFO - Running setup.py install for mozfile 03:21:06 INFO - Running setup.py install for mozhttpd 03:21:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:21:06 INFO - Running setup.py install for mozinfo 03:21:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:21:06 INFO - Running setup.py install for mozInstall 03:21:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:21:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:21:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:21:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:21:06 INFO - Running setup.py install for mozleak 03:21:06 INFO - Running setup.py install for mozlog 03:21:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:21:07 INFO - Running setup.py install for moznetwork 03:21:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:21:07 INFO - Running setup.py install for mozprocess 03:21:07 INFO - Running setup.py install for mozprofile 03:21:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:21:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:21:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:21:07 INFO - Running setup.py install for mozrunner 03:21:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:21:07 INFO - Running setup.py install for mozscreenshot 03:21:07 INFO - Running setup.py install for moztest 03:21:07 INFO - Running setup.py install for mozversion 03:21:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:21:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:21:07 INFO - Cleaning up... 03:21:07 INFO - Return code: 0 03:21:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:21:07 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')]} 03:21:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:07 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')]} 03:21:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:07 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 0x23a31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x270fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2713090>, '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 0x2713d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x270df90>, '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': 'ea65d483da93c827905c2090000001f5-1505290513.130544-8439048', '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 03:21:07 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 03:21:07 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 03:21:07 INFO - Using env: {'DISPLAY': ':0', 03:21:07 INFO - 'HOME': '/home/cltbld', 03:21:07 INFO - 'LANG': 'en_US.UTF-8', 03:21:07 INFO - 'LANGUAGE': 'en_US:en', 03:21:07 INFO - 'LOGNAME': 'cltbld', 03:21:07 INFO - 'MAIL': '/var/mail/cltbld', 03:21:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:07 INFO - 'MOZ_NO_REMOTE': '1', 03:21:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:21:07 INFO - 'NO_EM_RESTART': '1', 03:21:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:21:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:07 INFO - 'PWD': '/builds/slave/test', 03:21:07 INFO - 'SHELL': '/bin/bash', 03:21:07 INFO - 'SHLVL': '1', 03:21:07 INFO - 'TERM': 'linux', 03:21:07 INFO - 'TMOUT': '86400', 03:21:07 INFO - 'USER': 'cltbld', 03:21:07 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1505290513.130544-8439048', 03:21:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:07 INFO - '_': '/tools/buildbot/bin/python'} 03:21:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:21:08 INFO - Running setup.py (path:/tmp/pip-C94xQd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:21:08 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)) 03:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:21:08 INFO - Running setup.py (path:/tmp/pip-1fnex4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:21:08 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)) 03:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:21:08 INFO - Running setup.py (path:/tmp/pip-1ATGhK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:21:08 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)) 03:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:21:08 INFO - Running setup.py (path:/tmp/pip-91ygzC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:21:08 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)) 03:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:21:08 INFO - Running setup.py (path:/tmp/pip-QSb1yA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:21:08 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)) 03:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:21:08 INFO - Running setup.py (path:/tmp/pip-DmBSeH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:21:08 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)) 03:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:21:08 INFO - Running setup.py (path:/tmp/pip-x5Scax-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:21:08 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)) 03:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:21:08 INFO - Running setup.py (path:/tmp/pip-3HzQS8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:21:08 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)) 03:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:21:08 INFO - Running setup.py (path:/tmp/pip-QDJIc2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:21:08 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)) 03:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:21:08 INFO - Running setup.py (path:/tmp/pip-FDPyS6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:21:08 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)) 03:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:21:08 INFO - Running setup.py (path:/tmp/pip-aA4Znw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:21:08 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)) 03:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:21:08 INFO - Running setup.py (path:/tmp/pip-GbwjEe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:21:08 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)) 03:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:21:08 INFO - Running setup.py (path:/tmp/pip-lEPI7V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:21:09 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)) 03:21:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:21:09 INFO - Running setup.py (path:/tmp/pip-deA5Yu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:21:09 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)) 03:21:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:21:09 INFO - Running setup.py (path:/tmp/pip-IgU4u7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:21:09 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)) 03:21:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:21:09 INFO - Running setup.py (path:/tmp/pip-1xsgT8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:21:09 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)) 03:21:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:21:09 INFO - Running setup.py (path:/tmp/pip-7KRUz6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:21:09 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)) 03:21:09 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)) 03:21:09 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)) 03:21:09 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)) 03:21:09 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)) 03:21:09 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)) 03:21:09 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)) 03:21:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:21:09 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 03:21:09 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 03:21:09 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 03:21:09 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 03:21:10 INFO - Downloading blessings-1.6.tar.gz 03:21:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:21:10 INFO - Installing collected packages: blessings 03:21:10 INFO - Running setup.py install for blessings 03:21:10 INFO - Successfully installed blessings 03:21:10 INFO - Cleaning up... 03:21:10 INFO - Return code: 0 03:21:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:21:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:21:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:21:10 INFO - Reading from file tmpfile_stdout 03:21:10 INFO - Current package versions: 03:21:10 INFO - argparse == 1.2.1 03:21:10 INFO - blessings == 1.6 03:21:10 INFO - blobuploader == 1.2.4 03:21:10 INFO - docopt == 0.6.1 03:21:10 INFO - functools32 == 3.2.3-2 03:21:10 INFO - jsonschema == 2.5.1 03:21:10 INFO - manifestparser == 1.1 03:21:10 INFO - mozInstall == 1.13 03:21:10 INFO - mozcrash == 1.0 03:21:10 INFO - mozdebug == 0.1 03:21:10 INFO - mozdevice == 0.51 03:21:10 INFO - mozfile == 1.2 03:21:10 INFO - mozhttpd == 0.7 03:21:10 INFO - mozinfo == 0.10 03:21:10 INFO - mozleak == 0.1 03:21:10 INFO - mozlog == 3.5 03:21:10 INFO - moznetwork == 0.27 03:21:10 INFO - mozprocess == 0.25 03:21:10 INFO - mozprofile == 0.28 03:21:10 INFO - mozrunner == 6.13 03:21:10 INFO - mozscreenshot == 0.1 03:21:10 INFO - mozsystemmonitor == 0.3 03:21:10 INFO - moztest == 0.8 03:21:10 INFO - mozversion == 1.4 03:21:10 INFO - psutil == 3.1.1 03:21:10 INFO - requests == 1.2.3 03:21:10 INFO - wsgiref == 0.1.2 03:21:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:21:10 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')]} 03:21:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:10 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')]} 03:21:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:10 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 0x23a31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x270fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2713090>, '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 0x2713d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x270df90>, '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': 'ea65d483da93c827905c2090000001f5-1505290513.130544-8439048', '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 03:21:10 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 03:21:10 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 03:21:10 INFO - Using env: {'DISPLAY': ':0', 03:21:10 INFO - 'HOME': '/home/cltbld', 03:21:10 INFO - 'LANG': 'en_US.UTF-8', 03:21:10 INFO - 'LANGUAGE': 'en_US:en', 03:21:10 INFO - 'LOGNAME': 'cltbld', 03:21:10 INFO - 'MAIL': '/var/mail/cltbld', 03:21:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:10 INFO - 'MOZ_NO_REMOTE': '1', 03:21:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:21:10 INFO - 'NO_EM_RESTART': '1', 03:21:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:21:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:10 INFO - 'PWD': '/builds/slave/test', 03:21:10 INFO - 'SHELL': '/bin/bash', 03:21:10 INFO - 'SHLVL': '1', 03:21:10 INFO - 'TERM': 'linux', 03:21:10 INFO - 'TMOUT': '86400', 03:21:10 INFO - 'USER': 'cltbld', 03:21:10 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1505290513.130544-8439048', 03:21:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:10 INFO - '_': '/tools/buildbot/bin/python'} 03:21:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:11 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)) 03:21:11 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)) 03:21:11 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)) 03:21:11 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)) 03:21:11 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)) 03:21:11 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)) 03:21:11 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)) 03:21:11 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)) 03:21:11 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)) 03:21:11 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:21:11 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 03:21:11 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 03:21:11 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 03:21:11 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 03:21:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:21:12 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)) 03:21:12 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)) 03:21:12 INFO - Installing collected packages: simplejson 03:21:12 INFO - Running setup.py install for simplejson 03:21:12 INFO - building 'simplejson._speedups' extension 03:21:12 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 03:21:13 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 03:21:13 INFO - Successfully installed simplejson 03:21:13 INFO - Cleaning up... 03:21:13 INFO - Return code: 0 03:21:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:21:13 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')]} 03:21:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:13 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')]} 03:21:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:13 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 0x23a31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x270fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2713090>, '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 0x2713d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x270df90>, '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': 'ea65d483da93c827905c2090000001f5-1505290513.130544-8439048', '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 03:21:13 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 03:21:13 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 03:21:13 INFO - Using env: {'DISPLAY': ':0', 03:21:13 INFO - 'HOME': '/home/cltbld', 03:21:13 INFO - 'LANG': 'en_US.UTF-8', 03:21:13 INFO - 'LANGUAGE': 'en_US:en', 03:21:13 INFO - 'LOGNAME': 'cltbld', 03:21:13 INFO - 'MAIL': '/var/mail/cltbld', 03:21:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:13 INFO - 'MOZ_NO_REMOTE': '1', 03:21:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:21:13 INFO - 'NO_EM_RESTART': '1', 03:21:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:21:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:13 INFO - 'PWD': '/builds/slave/test', 03:21:13 INFO - 'SHELL': '/bin/bash', 03:21:13 INFO - 'SHLVL': '1', 03:21:13 INFO - 'TERM': 'linux', 03:21:13 INFO - 'TMOUT': '86400', 03:21:13 INFO - 'USER': 'cltbld', 03:21:13 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1505290513.130544-8439048', 03:21:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:13 INFO - '_': '/tools/buildbot/bin/python'} 03:21:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:21:13 INFO - Cleaning up... 03:21:13 INFO - Return code: 0 03:21:13 INFO - Running post-action listener: _resource_record_post_action 03:21:13 INFO - Running post-action listener: _start_resource_monitoring 03:21:13 INFO - Starting resource monitoring. 03:21:13 INFO - [mozharness: 2017-09-13 10:21:13.532730Z] Finished create-virtualenv step (success) 03:21:13 INFO - [mozharness: 2017-09-13 10:21:13.533241Z] Running install step. 03:21:13 INFO - Running pre-action listener: _resource_record_pre_action 03:21:13 INFO - Running main action method: install 03:21:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:21:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:21:13 INFO - Reading from file tmpfile_stdout 03:21:13 INFO - Detecting whether we're running mozinstall >=1.0... 03:21:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:21:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:21:13 INFO - Reading from file tmpfile_stdout 03:21:13 INFO - Output received: 03:21:13 INFO - Usage: mozinstall [options] installer 03:21:13 INFO - Options: 03:21:13 INFO - -h, --help show this help message and exit 03:21:13 INFO - -d DEST, --destination=DEST 03:21:13 INFO - Directory to install application into. [default: 03:21:13 INFO - "/builds/slave/test"] 03:21:13 INFO - --app=APP Application being installed. [default: firefox] 03:21:13 INFO - mkdir: /builds/slave/test/build/application 03:21:13 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'] 03:21:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:21:31 INFO - Reading from file tmpfile_stdout 03:21:31 INFO - Output received: 03:21:31 INFO - /builds/slave/test/build/application/firefox/firefox 03:21:31 INFO - Running post-action listener: _resource_record_post_action 03:21:31 INFO - [mozharness: 2017-09-13 10:21:31.679166Z] Finished install step (success) 03:21:31 INFO - [mozharness: 2017-09-13 10:21:31.679416Z] Running setup-mitmproxy step. 03:21:31 INFO - Running pre-action listener: _resource_record_pre_action 03:21:31 INFO - Running main action method: setup_mitmproxy 03:21:31 INFO - Skipping: mitmproxy is not required 03:21:31 INFO - Running post-action listener: _resource_record_post_action 03:21:31 INFO - [mozharness: 2017-09-13 10:21:31.680528Z] Finished setup-mitmproxy step (success) 03:21:31 INFO - [mozharness: 2017-09-13 10:21:31.680752Z] Running run-tests step. 03:21:31 INFO - Running pre-action listener: _resource_record_pre_action 03:21:31 INFO - Running pre-action listener: _set_gcov_prefix 03:21:31 INFO - Running main action method: run_tests 03:21:31 WARNING - Try message not found. 03:21:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:21:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:21:31 INFO - Python 2.7.3 03:21:31 INFO - Return code: 0 03:21:31 INFO - grabbing minidump binary from tooltool 03:21:31 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')]} 03:21:31 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 0x2713090>, '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 0x2713d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x270df90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:21:31 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 03:21:31 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 03:21:31 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 03:21:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:21:31 INFO - Return code: 0 03:21:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:21:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:21:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:21:31 INFO - ENV: RUST_BACKTRACE is now full 03:21:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:21:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:21:31 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/TFFNhlJXQAqdPaYDbVW9jw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-084', '--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 03:21:31 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/TFFNhlJXQAqdPaYDbVW9jw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-084 --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 03:21:31 INFO - Using env: {'DISPLAY': ':0', 03:21:31 INFO - 'HOME': '/home/cltbld', 03:21:31 INFO - 'LANG': 'en_US.UTF-8', 03:21:31 INFO - 'LANGUAGE': 'en_US:en', 03:21:31 INFO - 'LOGNAME': 'cltbld', 03:21:31 INFO - 'MAIL': '/var/mail/cltbld', 03:21:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:21:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:21:31 INFO - 'MOZ_ACCELERATED': '1', 03:21:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:31 INFO - 'MOZ_NO_REMOTE': '1', 03:21:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:21:31 INFO - 'MOZ_WEBRENDER': '1', 03:21:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:21:31 INFO - 'NO_EM_RESTART': '1', 03:21:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:21:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:31 INFO - 'PWD': '/builds/slave/test', 03:21:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:21:31 INFO - 'RUST_BACKTRACE': 'full', 03:21:31 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:21:31 INFO - 'SHELL': '/bin/bash', 03:21:31 INFO - 'SHLVL': '1', 03:21:31 INFO - 'TERM': 'linux', 03:21:31 INFO - 'TMOUT': '86400', 03:21:31 INFO - 'USER': 'cltbld', 03:21:31 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1505290513.130544-8439048', 03:21:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:31 INFO - '_': '/tools/buildbot/bin/python'} 03:21:31 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/TFFNhlJXQAqdPaYDbVW9jw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-084', '--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 03:21:32 INFO - mozversion application_buildid: 20170913092825 03:21:32 INFO - mozversion application_changeset: 9873269746359dbcccbd5b44f0e82c0225289945 03:21:32 INFO - mozversion application_display_name: Nightly 03:21:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:21:32 INFO - mozversion application_name: Firefox 03:21:32 INFO - mozversion application_remotingname: firefox 03:21:32 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:21:32 INFO - mozversion application_vendor: Mozilla 03:21:32 INFO - mozversion application_version: 57.0a1 03:21:32 INFO - mozversion platform_buildid: 20170913092825 03:21:32 INFO - mozversion platform_changeset: 9873269746359dbcccbd5b44f0e82c0225289945 03:21:32 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:21:32 INFO - mozversion platform_version: 57.0a1 03:21:32 INFO - using testdate: 1505298092 03:21:32 INFO - actual date: 1505298092 03:21:32 INFO - starting webserver on 'localhost:60337' 03:21:32 INFO - SUITE-START | Running 2 tests 03:21:32 INFO - TEST-START | dromaeo_css 03:21:32 INFO - Initialising browser for dromaeo_css test... 03:21:32 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:60337/getInfo.html -profile /tmp/tmp8m1x6o/profile 03:21:32 INFO - TEST-INFO | started process 23811 (/builds/slave/test/build/application/firefox/firefox http://localhost:60337/getInfo.html) 03:21:38 INFO - TEST-INFO | 23811: exit 0 03:21:38 INFO - Browser initialized. 03:21:38 INFO - Running cycle 1/1 for dromaeo_css test... 03:21:38 INFO - Using env: {'DISPLAY': ':0', 03:21:38 INFO - 'HOME': '/home/cltbld', 03:21:38 INFO - 'JSGC_DISABLE_POISONING': '1', 03:21:38 INFO - 'LANG': 'en_US.UTF-8', 03:21:38 INFO - 'LANGUAGE': 'en_US:en', 03:21:38 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:21:38 INFO - 'LOGNAME': 'cltbld', 03:21:38 INFO - 'MAIL': '/var/mail/cltbld', 03:21:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:21:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:21:38 INFO - 'MOZ_ACCELERATED': '1', 03:21:38 INFO - 'MOZ_CRASHREPORTER': '1', 03:21:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:38 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:21:38 INFO - 'MOZ_NO_REMOTE': '1', 03:21:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:21:38 INFO - 'MOZ_WEBRENDER': '1', 03:21:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:21:38 INFO - 'NO_EM_RESTART': '1', 03:21:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:21:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:38 INFO - 'PWD': '/builds/slave/test', 03:21:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:21:38 INFO - 'RUST_BACKTRACE': 'full', 03:21:38 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:21:38 INFO - 'SHELL': '/bin/bash', 03:21:38 INFO - 'SHLVL': '1', 03:21:38 INFO - 'TERM': 'linux', 03:21:38 INFO - 'TMOUT': '86400', 03:21:38 INFO - 'USER': 'cltbld', 03:21:38 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1505290513.130544-8439048', 03:21:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:38 INFO - '_': '/tools/buildbot/bin/python'} 03:21:38 INFO - TEST-INFO | started process 24008 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8m1x6o/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:21:39 INFO - PID 24008 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:21:39 INFO - PID 24008 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:21:40 INFO - PID 24008 | 03:21:40 INFO - PID 24008 | (/builds/slave/test/build/application/firefox/firefox:24067): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:21:40 INFO - PID 24008 | 03:21:50 INFO - PID 24008 | RSS: Main: 212791296 03:21:50 INFO - PID 24008 | 03:24:48 INFO - PID 24008 | Cycle 1(1): loaded http://localhost:60337/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60337/tests/dromaeo/cssquery-ext.html) 03:24:49 INFO - PID 24008 | RSS: Main: 218931200 03:24:49 INFO - PID 24008 | 03:27:51 INFO - PID 24008 | Cycle 1(1): loaded http://localhost:60337/tests/dromaeo/cssquery-ext.html (next: http://localhost:60337/tests/dromaeo/cssquery-jquery.html) 03:27:52 INFO - PID 24008 | RSS: Main: 221450240 03:27:52 INFO - PID 24008 | 03:30:54 INFO - PID 24008 | Cycle 1(1): loaded http://localhost:60337/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60337/tests/dromaeo/cssquery-mootools.html) 03:30:54 INFO - PID 24008 | RSS: Main: 224002048 03:30:54 INFO - PID 24008 | 03:33:57 INFO - PID 24008 | Cycle 1(1): loaded http://localhost:60337/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60337/tests/dromaeo/cssquery-prototype.html) 03:33:57 INFO - PID 24008 | RSS: Main: 219377664 03:33:57 INFO - PID 24008 | 03:37:01 INFO - PID 24008 | Cycle 1(1): loaded http://localhost:60337/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60337/tests/dromaeo/cssquery-yui.html) 03:37:01 INFO - PID 24008 | RSS: Main: 223858688 03:37:01 INFO - PID 24008 | 03:40:03 INFO - PID 24008 | Cycle 1(1): loaded http://localhost:60337/tests/dromaeo/cssquery-yui.html (next: http://localhost:60337/tests/dromaeo/cssquery-dojo.html) 03:40:03 INFO - PID 24008 | RSS: Main: 224276480 03:40:03 INFO - PID 24008 | 03:40:03 INFO - PID 24008 | __start_tp_report 03:40:03 INFO - PID 24008 | _x_x_mozilla_page_load 03:40:03 INFO - PID 24008 | _x_x_mozilla_page_load_details 03:40:03 INFO - PID 24008 | |i|pagename|runs| 03:40:03 INFO - PID 24008 | |0;dojo.html;3128.6402063762666;3150.991682661549;3152.085895090424;3155.5582218489417;3187.82466964317;6127.724252408641;6283.183186185795;6313.337099604544;6316.336784637604;6393.4565561927175;6159.507239420846;6262.373762623735;6276.968615156929;6299.401556852092;6310.24277086749;5709.714514274269;5762.82711518653;5766.250387449636;5801.100829371454;5823.388544202861;5746.798862039829;5802;5810.418958104198;5812.186293918855;5836.854078648025;5821.708914554277;5831.475167234969;5872.324682661484;5879.823605291848;5916.142159386886;5520.751566179531;5617.21359009739;5849.7660093596205;5855.151003104568;5910.143029260755;5282.788688452457;5738.110592858072;5831.096180092092;5836.5914385993;5865.061590145556;6175.66033868137;6223.346548612421;6362.2365316161895;6365.872682546323;6370.044493326038;6461.12774775404;6483.7082331295205;6631.4363279121335;6722.193336799566;6727.495437842182;6788.08360871281;6854.485913556453;6854.691538880762;6861.965690171567;6862.382385585272;6121.479674227696;6206.658633775095;6262.718177682015;6344.1435406220035;6351.587146835487;6883.242843287235;6988.720451181997;7027.754028608974;7077.5753454792875;7078.646067696594;6616.636085015371;6635.900461493082;6667.63328016954;6698.4306333961185;6705.6982435790505;6466.321036291121;6591.110200123018;6602.1747281589805;6610.107635469246;6621.5364924454825;6563.671816409161;6590.176227971504;6594.109795177686;6602.8349291268105;6672.766453174213;6772.695228714621;6789.796306110825;6821.522493425512;6831.04365388846;6832.385085342343;5205.635605507654;5294.364676238799;5295.973520132375;5333.439988801198;5348.812791552277;4593.54064593538;4597.241455159861;4668.743219122981;4675.392199014174;4676.088162808288;5646.689432081275;5736.282964629421;5736.827895163152;5739.8565035874435;5744.425557444222;6619.768308109193;6657.833554161185;6665.100211471487;6671.3328667133865;6675.532712710064;5723.170140329629;5728.427157284238;5737.569682273846;5793.304803423532;5804.332501762267;5792.4497172768515;5819.243498345273;5840.29916410025;5849.151872978395;5863.442972917566;6526.771562995273;6528.836779080466;6537.738490460423;6614.338566143347;6616.66916654175;6481.837954051187;6581.9670901647105;6603.471722262304;6607.0419789131265;6616.900746488903;6356.269029061717;6367.713452894538;6369.172007638977;6372.044193371032;6407.743690252524;6602.141721576164;6640.966795165993;6647.335266473314;6713.932860671331;6717.832054198684;6708.765193218214;6775.966120169368;6805.727770889307;6836.623985680636;6839.692213850488;6332.905006424815;6428.19647544057;6463.095166676763;6484.28672845996;6599.967000164968;6415.807525774234;6417;6424.967875160594;6426.260979987362;6431.614103153825;6351.30135685065;6356.141920840812;6363.522735794926;6371.458426033839;6374.107624932421;6510.056041873807;6643.833904152435;6651.401373876374;6714.127163468913;6731.091302674272;6210.782622608187;6333.524985626004;6374;6389.073584330339;6495.382938620824 03:40:03 INFO - PID 24008 | |1;ext.html;851.978700532487;885.4067774591024;893.6648756716231;904.7602385367878;907.0702529906845;41582.58417415825;42176.78911605445;42359.78820105895;42601.14797704044;42708.786456067755;39638.20723585527;39851.21413465723;39878;40166.39750403739;40283.19433611326;7044.788656340318;7060.0468936693405;7108.360247577717;7120.038794762692;7126.608036557987;7112.751053713121;7178.533395329313;7186.928130718678;7200.027996220521;7219.711211551558;7162.104736907887;7176.533525320838;7191.928080719204;7205.639718014105;7221.675024623904;7055.964720176392;7718.575478348716;7866.252705992922;7883.935668684711;7931.920680793233;7724.266194711493;7741.651625676858;7832.412569057344;7843.529388236724;7863.882041769378;38529.61470385316;38803.61196388056;38823.61176388228;38885;39986;3503.316853213624;3555.7333200010103;3555.9466608000903;3556.822158892045;3558.6085530591613;32908.6709132908;32919.83540082284;33150.33699326024;33176.6682333176;33340;5159.974200128975;5196.844094677166;5204;5242.213667949838;5253.028189784902;186802;188331;188715;188908.99999999863;190067;49118.508814911394;49303.260451093265;49577.75211123993;49620.25569616459;49648;51608;51747.48252517502;51934;52429.475705243225;52498;15561;15654.45209417665;15763.290651920692;15773;15792.684146317239;12632.557860474839;12681.365931703378;12689.428975696115;12766.68083297925;12767.936160319325;14741.484048058266;14777.187254701095;14779.704405912036;14820;15052.72051875581;5750.7987220447085;5806.680632565165;5878.823635290948;5917.201177841022;6090.512758979271;993.8807343118727;1002.0880998291519;1012.9493525323704;1017.6743442098606;1038.3043360948184;23408.64887026696;23449.41376465602;23460.64809027866;23494.177703780286;23636.7636323638;1108.578740078765;1109.5007246738837;1114.509615769059;1120.8598925134359;1122.2200570603352;12249.571265005681;12351.25892446456;12351.567695130807;12408;12470.251784892935;229199;231720;232290;232359;232531;45489.77255113769;46783.766081170055;53371.19943200855;55004.449955500735;55785.44214557884;1440.6110350205595;1455.4614792526834;1478.8742956848573;1481.2001519179737;1498.2059508460534;26988.595171072844;27221.455570888076;27399.178024659293;27663.585046224725;27673.308167295174;38079.80960095182;38122.809385952896;38370.2325953485;38385.23229535338;38405;190317;192206;192827;194267;195428;35907.102322441104;35965.28069438649;36279.274414511034;36463.27073458569;36537.63462365342;43565;44729.77635111804;44764.32853507135;45414.772926135156;45470.77264613656;31777.682223178395;31963.36073278568;32031.35937281195;32436;32972.83513582417;31623.20941976469;31638.841805790824;32052.83973580117;32186.03441896747;32340.514892277104;35096.64903350934;36604.90185294445;36645.816770915975;36934;37091.629083708816;30769.230769230948;30903.2274193147;31002.534961975136;31195.84402077975;32168;22630;22880.427989300402;23271.1855085078;23412.361134721086;23725.406864828517 03:40:03 INFO - PID 24008 | |2;jquery.html;538.7521739999597;538.9784408623656;542.9565634749221;560.1094260126399;593.376954198092;22009.339719808413;22687.432814179654;22702.659460108112;22702.77297227027;22764.317070487872;22685.659715104288;24576.385590360205;24895.626565601484;24971.62542561863;24977.125800596983;6327.4938004959495;6412.775552855651;6460.515461340395;6466.385693359123;6495.610263384188;6349.587276827015;6435.324290949453;6465.224173099235;6474;6478.54650174488;6278.183836101301;6436.195475565554;6583.80248592543;6601.372869577406;6606.2733099359275;6477.352264773508;6505.251896031969;6529.183852018497;6548.967255163718;6549.639769812658;6029.336772954972;6046;6078.635281883101;6087.1173679816175;6711.194656641234;29454;29747;29804.403911921858;29828.552571711443;29966.250843728863;2038.2356616268899;2073.39871437283;2073.7718850926385;2076.9480762980897;2079.625667379871;19683.901580492005;20008.399748007436;20347.084381202734;20379.79620203794;20470.283540076027;2519.710233323173;2564.6537717408282;2591.5076135534187;2607.4524349886547;2614.307208589725;123578;131770;143220;150487;150961;20249.797502025085;20487.282945097148;20991.580168396853;21785;22358.217462388737;41808.58191418108;42202;42388.364174537404;42497.57502424998;42562.57437425586;10919.608424799888;11136;11152;11223.887761122447;11308.886911130783;9222.354435189607;9262.907370926205;9283.860742088875;9298.581563829644;9517.90482095184;11111.944440277746;11429.59996400122;11536.365499897585;11601.883981160248;11788.174827761974;3923.5487918889694;4262.680298977589;4295.484541854998;4334.7399156050105;4378.978504831656;948.4641177734558;961.1541843178098;973.7955029443755;974.1524873360222;980.5244456438621;18334.633307334047;18365.81634183668;18775.0612469376;18894.811051889305;18935;1021.8722659667542;1026.8870424253325;1041.671873359889;1044.9895501045044;1047.272145858621;10555.683329500127;10568.894311056945;10656.946715266375;10741.83887241692;10906.890931090587;448068;457632;462415;465299;467242;107804;112300;112372.43813781043;112540;112775.43612281886;1026.8767747870304;1130.3500487219717;1140.8003599370077;1182.0366401382846;1191.4697959408154;19782.90108549448;19879.30422435208;19893.801061989194;20397.592048158658;20527.4868128292;53361.46638533565;53866.73066634642;54223.45776542184;54784.452155477935;56027;68869.65565172142;69096;69787;70212.29787702058;71677.64161179161;19147.329843455413;19603.901980490005;19811.504712382306;19902.800971990095;19954.60090798205;22045.889770551687;22379.888100559394;22381.66427503556;22461.663075054214;22518.32445026652;17903.73144402861;17945.820541794415;18018.909905450913;18025.819741802414;18036.54908627295;15813.604659883595;16477.093759843323;16480.505584832474;16726;16844.831551684325;17022.57443563921;17984.910075449538;18210;18558.350457733915;18596.25614975386;19175.232990680775;19203.90398048001;19229;19271.325503607306;19355;18010.72983905269;18043;18104.551635868836;18106.09469526545;18193.272269109617 03:40:03 INFO - PID 24008 | |3;mootools.html;1327.1042046618534;1417.5251290817578;1418.1561970627472;1431.4703559682919;1442.1419255542955;14815.777763333559;15323.233838308082;15444.227788610553;15447.150406727626;15450.69098618027;15153.393864245418;15262.694746105071;15278.694426111471;15291.464798732046;15304.311305991228;2704.5672692369226;2726.877290521926;2772.1129238643643;2772.5286701260834;2772.875220615067;2594.8313359631657;2687.852168130752;2689.623452716621;2698.406350602864;2706.2557796605893;2588.7281835407293;2672.2784848091005;2756.8483733394655;2780.457810726909;2786.749192572668;2716.8641567921527;2744.8353098814036;2747.821391609539;2771.2656146121194;2777.722227777216;2471.480988992296;2507.5486412445753;2679.115891755716;2694.609281654149;2697.892084316625;14999.325030373659;15154.545363639108;15218.46735364268;15387.538373848802;15408.3836646534;7850.646720897574;8221.876671849926;8225.83548329036;8289.917100828974;8301.958490207511;5026.824061157842;5192.974035129838;5267.157254839208;5309.203619457074;5349.545288650469;1963.9116239769244;1965.0960558143272;1988.6420444320017;2011.054804242004;2027.5843452092286;26782.46435071307;26957.865210674016;27054.729452705615;27068.293170682773;27080.59379109315;6514.934850651528;6633.767818126439;6737.562058466184;6763.512027353974;6880.965595171992;17533.386331478338;17663.64672706539;17704.29182832698;17737.822621773874;17742.024188669748;7914.129445760962;8052.315553177928;8054.436189466798;8068.314193293519;8076.152004039609;7203.135623725187;7310.34206921369;7344.816379590553;7440.73957411488;7524.548527088392;5293.100172970604;5353;5378.354597448331;5381.730913454312;5634.126710359901;1405.7680482720236;1463.8975271730876;1512.251435539415;1518.324345666168;1519.2859356102615;862.3403096631082;915.2586405011962;924.306769922558;935.3452583191793;935.6117211357347;8297.543635100006;8385.538795366314;8529.616167272488;8533.104024077382;8555.187257210555;799.7400844725488;991.548845275398;999.3004896572428;1008.7528555503949;1012.3925644613173;5250.396204436539;5383.219433182245;5497;5615.522680572197;5715.457031581993;21410.143594256057;22003.559928801653;22184.33446996593;22476.32571022872;22520.54958900813;21090.78909210919;21509.13963441445;21954.45113872134;22183.66724499134;22209;10772.138228941823;11539.76920461586;11567.248128871764;11579.88420115788;11594.47824847884;7994.720184793504;8323.084460709439;8368.623411946355;8471.957640212006;8535.8719619207;18391.63216735631;18943.33698320552;19073.618527629093;19151.61696766029;19279;19221.807781922;19415.70876436883;19641.31255406054;19796.307129250406;20054.398368048984;10322.845157322796;10495.895041049796;10640.946795266284;10655.946720266349;10658.253922225369;13591.864081359456;13948.79076813869;13983.790243146157;13996.16023038621;14009.299535023412;11303;11332;11464.082873370277;11481.712957176138;11724.648260552198;11084.16868734832;11247.212695111264;11391.544338226378;11423.029042531478;11500.367479788692;10199.949000254952;10353.06822385989;10423.68728938133;10427.061564459234;10455.94772026135;7526.285002924714;7540.245975402416;7634.389248859967;7642.961785191039;7744.225577442211;7526.24737526243;7647.847043059219;7758.806029849299;7803.0636323639255;7848.607569621382 03:40:03 INFO - PID 24008 | |4;prototype.html;484.23490884402645;510.19898758948466;517.9378474583049;521.1167071813276;523.9083160446922;6066.452090122149;6160.876782464348;6171.506279497647;6206.162168107304;6229.719662615182;5829.650220986733;6034.547408944336;6072.846159229754;6093.482054025402;6111.075011371415;5108.4125325587665;5112.999999999991;5137.434882162977;5142.691438513682;5154.819581314655;4801.687890287138;4900.411950565919;5098.847034588968;5101.642884998052;5145.614078944075;4842.29786680931;4861.635377346695;4870.318155458239;4918.188498897677;4925.556699897009;4866.099771542276;4878.0975519529;4901.965684241053;4913.557779799818;4922.8769280768265;4381.671374646882;4412.845550405753;4424.690271680984;4431.255589027299;4434.645228381722;5960.582759206857;5983.850403739898;5992.400759924017;6008.7896923607905;6031.396860313934;5578.163275508666;5645.23789288449;5646.57650676201;5649.265595472562;5672.347680016768;6301.495880329563;6387.361263873622;6390.233172019341;6393.584417012879;6398.29618741938;4758.405199350082;4770.880727981794;4771.665983381165;4785.521447855222;4795.880102997418;6307.180066591313;6307.7161527730905;6436.710348034349;6575.243846957565;6697.966510167466;4880.170371036932;4909.70541767488;4914.655974081851;4938.38270216223;4945.159322915113;4920.950790492049;4962.702237865739;4974.850754477371;4991.750412479361;4993.575546078551;5492.835214943558;5511.917321240185;5513.889722205614;5516.338039435213;5610.775568977277;6342.238931328178;6405.42351188386;6422.421982021547;6423.903641445382;6452.935470645328;1702.5232934778282;1728.6888360095052;1730.0138920815014;1731.9002433454596;1732.7141021731525;1128.7178205448638;1194.6023152911114;1196.9700757481132;1198.3349241171059;1218.6161359171833;5496.945030549643;5514.172874068921;5554.527865131428;5568.693721845257;5610.635308704921;6419.7802417540515;6437.871242575216;6442.871142577123;6517.250516190604;6549.312322206195;5553.666779993213;5557.777688892399;5600.915986260209;5636.408177141423;5649.689267090267;3425.828708564562;3432.553768010143;3443.776154549946;3453.6028356738793;3453.706434953007;6298.716557754912;6320.178376810985;6320.62076275425;6321.241451025906;6340.270868850142;6586.242582103119;6630.602163870183;6677.465802735769;6746.156730408699;6779.593224406552;6125.2649682037545;6164.965561364828;6321.336259692666;6337.271213810379;6342.873142537123;5985.354027642433;6329.968350158219;6448.226212854487;6470.126532917996;6523.412892839668;6312.3056463788025;6319.557630965788;6347.5556711029785;6394.6482943436695;6419.261784894797;6044.637321760709;6104.04670505434;6130.386961303834;6161.383861613803;6171.290301615371;4789;4839.128956787812;4895.339129217653;4964.900701986012;4965.379327584052;6142.938570614237;6374.74501019954;6380.489560835029;6437.1631687882145;6592.274849766618;6294.087357333253;6306.46395056407;6377.649229292433;6379.936200637934;6415.486761059011;6270.843228919313;6360.777372792115;6370.649614271074;6385.96807015962;6416.7754128605275;6304.18045654062;6312.4634406076;6322.557420980487;6345.841353966188;6349.301576826453;6464.547481676237;6475;6491.955034164223;6503.934960650522;6530.314316996647;6179.62922224668;6241.812745617639;6252.781152659635;6271.310155882758;6280.183576135073 03:40:03 INFO - PID 24008 | |5;yui.html;903.1059251341172;908.7092130518237;921.7188757428986;926.5598840550736;929.0338048429634;19533;19765.308214212506;20008.0996355164;20244.898775506103;20246.29137980171;18779.906100469478;18921.905390473028;19021.144048517814;19130.234790608392;19192.808071919277;974.585801034561;975.0395860077817;984.9950750246275;986.7039888033597;988.6539711101093;968.9127978481936;990.529498488216;991.504247876062;995.2088089968493;1001.2940876681922;1051.3901936876593;1052.6841947415783;1052.8052310322576;1055.551390658967;1058.7723639417525;998.3959704378818;1053.4258828938248;1054.4991129213602;1054.6888667842966;1056.5773690523774;744.5197847388404;759.1687102622619;759.3431681595436;762.1578156137443;763.7632333976485;20095.799042009538;20292;20322.390328290174;20380.796192038037;20386.388408347775;21456.89271553648;21799;22388.776112238997;22540.32379028632;22580.66129008066;17589.56026099345;17808.198631061503;18038;18176.091195440174;18193.999330036844;3766.3408903441787;3770.6040865709256;3793.279276937373;3797.696184305249;3800.5819359870393;141752;142838;143409;150653;153678;16756;17038.57403564921;17149.828501715074;17160.570985725208;17172;31139;32212.677873221437;32399.352012959607;32456.675433245837;32635.836820816217;8275.917240827635;8456.06983231844;8560.914390856136;8612.267957223707;8628.137186281447;4207.768572728468;4311.633511151587;4312.116016216731;4320.265554855682;4335.328024156261;5535.03136951032;5623.6906970116215;5624.21261023457;5642.520385767174;5644.125160600031;947.924166066713;949.093615597103;963.7157038673608;987.693814917378;1001.9599216031423;680.2279412866433;691.9169699636076;696.5681277607915;699.618707804248;712.982175445618;10563.63027294041;10827.83758243627;10877.347359158475;11717.238379505305;12327.198732082386;663.6814329122049;673.2997682410337;682.9795106146823;688.8036909480774;693.9514234003673;5140.460251673595;5189.117849965515;5213.504717051874;5338.386085600128;5343.759530821122;123951;124423;124844.37577812053;124962;125046;85140;108035.45982270196;113262.43368783269;113452.16369590661;114424;92092;93097.53451232836;94889;97079.51460242795;98169;12113.15207935436;12394.938025309815;12496.25022498653;12505.43725532335;12575.622731318075;42774.35838462488;42927.71216863499;43858.56141438672;43974.90062748457;44651.776741117385;56535;59685.40314596798;60024.09963850459;60479.69760151171;60609.39390606037;18629.813701862808;19133.904330478257;19186.040697965323;19307;19332.4200273992;21763.23828665989;21808.12767489346;21955.560888782453;22100.778992210515;22165.556688866454;19119.90440047791;19342.129604167563;19418.90290548538;19701;19734;18523.44429667112;18656.626867462302;18717.06414679288;18795.624087518445;19242.7113593299;17504.82495175083;17513.912430438275;17544.73682894732;17673.381431649832;17678.823211767718;12554;12744.74510509803;12746.42641081172;12886.226826390446;13082;13111.93444032812;13392.665183370495;13473.528426505025;13484.32578371058;13506.189628622315 03:40:03 INFO - PID 24008 | __end_tp_report 03:40:03 INFO - PID 24008 | __start_cc_report 03:40:03 INFO - PID 24008 | _x_x_mozilla_cycle_collect,344 03:40:03 INFO - PID 24008 | __end_cc_report 03:40:03 INFO - PID 24008 | __startTimestamp1505299203976__endTimestamp 03:40:03 INFO - PID 24008 | 03:40:03 INFO - PID 24008 | ------- Summary: start ------- 03:40:03 INFO - PID 24008 | Number of tests: 6 03:40:03 INFO - PID 24008 | 03:40:03 INFO - PID 24008 | [#0] dojo.html Cycles:165 Average:6164.22 Median:6370.04 stddev:734.75 (11.5%) stddev-sans-first:697.34 03:40:03 INFO - PID 24008 | Values: 3128.6 3151.0 3152.1 3155.6 3187.8 6127.7 6283.2 6313.3 6316.3 6393.5 6159.5 6262.4 6277.0 6299.4 6310.2 5709.7 5762.8 5766.3 5801.1 5823.4 5746.8 5802.0 5810.4 5812.2 5836.9 5821.7 5831.5 5872.3 5879.8 5916.1 5520.8 5617.2 5849.8 5855.2 5910.1 5282.8 5738.1 5831.1 5836.6 5865.1 6175.7 6223.3 6362.2 6365.9 6370.0 6461.1 6483.7 6631.4 6722.2 6727.5 6788.1 6854.5 6854.7 6862.0 6862.4 6121.5 6206.7 6262.7 6344.1 6351.6 6883.2 6988.7 7027.8 7077.6 7078.6 6616.6 6635.9 6667.6 6698.4 6705.7 6466.3 6591.1 6602.2 6610.1 6621.5 6563.7 6590.2 6594.1 6602.8 6672.8 6772.7 6789.8 6821.5 6831.0 6832.4 5205.6 5294.4 5296.0 5333.4 5348.8 4593.5 4597.2 4668.7 4675.4 4676.1 5646.7 5736.3 5736.8 5739.9 5744.4 6619.8 6657.8 6665.1 6671.3 6675.5 5723.2 5728.4 5737.6 5793.3 5804.3 5792.4 5819.2 5840.3 5849.2 5863.4 6526.8 6528.8 6537.7 6614.3 6616.7 6481.8 6582.0 6603.5 6607.0 6616.9 6356.3 6367.7 6369.2 6372.0 6407.7 6602.1 6641.0 6647.3 6713.9 6717.8 6708.8 6776.0 6805.7 6836.6 6839.7 6332.9 6428.2 6463.1 6484.3 6600.0 6415.8 6417.0 6425.0 6426.3 6431.6 6351.3 6356.1 6363.5 6371.5 6374.1 6510.1 6643.8 6651.4 6714.1 6731.1 6210.8 6333.5 6374.0 6389.1 6495.4 03:40:03 INFO - PID 24008 | 03:40:03 INFO - PID 24008 | [#1] ext.html Cycles:180 Average:37702.21 Median:35936.19 stddev:53173.26 (148.0%) stddev-sans-first:53250.43 03:40:03 INFO - PID 24008 | Values: 852.0 885.4 893.7 904.8 907.1 41582.6 42176.8 42359.8 42601.1 42708.8 39638.2 39851.2 39878.0 40166.4 40283.2 7044.8 7060.0 7108.4 7120.0 7126.6 7112.8 7178.5 7186.9 7200.0 7219.7 7162.1 7176.5 7191.9 7205.6 7221.7 7056.0 7718.6 7866.3 7883.9 7931.9 7724.3 7741.7 7832.4 7843.5 7863.9 38529.6 38803.6 38823.6 38885.0 39986.0 3503.3 3555.7 3555.9 3556.8 3558.6 32908.7 32919.8 33150.3 33176.7 33340.0 5160.0 5196.8 5204.0 5242.2 5253.0 186802.0 188331.0 188715.0 188909.0 190067.0 49118.5 49303.3 49577.8 49620.3 49648.0 51608.0 51747.5 51934.0 52429.5 52498.0 15561.0 15654.5 15763.3 15773.0 15792.7 12632.6 12681.4 12689.4 12766.7 12767.9 14741.5 14777.2 14779.7 14820.0 15052.7 5750.8 5806.7 5878.8 5917.2 6090.5 993.9 1002.1 1012.9 1017.7 1038.3 23408.6 23449.4 23460.6 23494.2 23636.8 1108.6 1109.5 1114.5 1120.9 1122.2 12249.6 12351.3 12351.6 12408.0 12470.3 229199.0 231720.0 232290.0 232359.0 232531.0 45489.8 46783.8 53371.2 55004.4 55785.4 1440.6 1455.5 1478.9 1481.2 1498.2 26988.6 27221.5 27399.2 27663.6 27673.3 38079.8 38122.8 38370.2 38385.2 38405.0 190317.0 192206.0 192827.0 194267.0 195428.0 35907.1 35965.3 36279.3 36463.3 36537.6 43565.0 44729.8 44764.3 45414.8 45470.8 31777.7 31963.4 32031.4 32436.0 32972.8 31623.2 31638.8 32052.8 32186.0 32340.5 35096.6 36604.9 36645.8 36934.0 37091.6 30769.2 30903.2 31002.5 31195.8 32168.0 22630.0 22880.4 23271.2 23412.4 23725.4 03:40:03 INFO - PID 24008 | 03:40:03 INFO - PID 24008 | [#2] jquery.html Cycles:180 Average:34845.86 Median:22202.05 stddev:77796.13 (350.4%) stddev-sans-first:77971.73 03:40:03 INFO - PID 24008 | Values: 538.8 539.0 543.0 560.1 593.4 22009.3 22687.4 22702.7 22702.8 22764.3 22685.7 24576.4 24895.6 24971.6 24977.1 6327.5 6412.8 6460.5 6466.4 6495.6 6349.6 6435.3 6465.2 6474.0 6478.5 6278.2 6436.2 6583.8 6601.4 6606.3 6477.4 6505.3 6529.2 6549.0 6549.6 6029.3 6046.0 6078.6 6087.1 6711.2 29454.0 29747.0 29804.4 29828.6 29966.3 2038.2 2073.4 2073.8 2076.9 2079.6 19683.9 20008.4 20347.1 20379.8 20470.3 2519.7 2564.7 2591.5 2607.5 2614.3 123578.0 131770.0 143220.0 150487.0 150961.0 20249.8 20487.3 20991.6 21785.0 22358.2 41808.6 42202.0 42388.4 42497.6 42562.6 10919.6 11136.0 11152.0 11223.9 11308.9 9222.4 9262.9 9283.9 9298.6 9517.9 11111.9 11429.6 11536.4 11601.9 11788.2 3923.5 4262.7 4295.5 4334.7 4379.0 948.5 961.2 973.8 974.2 980.5 18334.6 18365.8 18775.1 18894.8 18935.0 1021.9 1026.9 1041.7 1045.0 1047.3 10555.7 10568.9 10656.9 10741.8 10906.9 448068.0 457632.0 462415.0 465299.0 467242.0 107804.0 112300.0 112372.4 112540.0 112775.4 1026.9 1130.4 1140.8 1182.0 1191.5 19782.9 19879.3 19893.8 20397.6 20527.5 53361.5 53866.7 54223.5 54784.5 56027.0 68869.7 69096.0 69787.0 70212.3 71677.6 19147.3 19603.9 19811.5 19902.8 19954.6 22045.9 22379.9 22381.7 22461.7 22518.3 17903.7 17945.8 18018.9 18025.8 18036.5 15813.6 16477.1 16480.5 16726.0 16844.8 17022.6 17984.9 18210.0 18558.4 18596.3 19175.2 19203.9 19229.0 19271.3 19355.0 18010.7 18043.0 18104.6 18106.1 18193.3 03:40:03 INFO - PID 24008 | 03:40:03 INFO - PID 24008 | [#3] mootools.html Cycles:180 Average:9466.59 Median:2633.55 stddev:6785.33 (257.6%) stddev-sans-first:6776.80 03:40:04 INFO - PID 24008 | Values: 1327.1 1417.5 1418.2 1431.5 1442.1 14815.8 15323.2 15444.2 15447.2 15450.7 15153.4 15262.7 15278.7 15291.5 15304.3 2704.6 2726.9 2772.1 2772.5 2772.9 2594.8 2687.9 2689.6 2698.4 2706.3 2588.7 2672.3 2756.8 2780.5 2786.7 2716.9 2744.8 2747.8 2771.3 2777.7 2471.5 2507.5 2679.1 2694.6 2697.9 14999.3 15154.5 15218.5 15387.5 15408.4 7850.6 8221.9 8225.8 8289.9 8302.0 5026.8 5193.0 5267.2 5309.2 5349.5 1963.9 1965.1 1988.6 2011.1 2027.6 26782.5 26957.9 27054.7 27068.3 27080.6 6514.9 6633.8 6737.6 6763.5 6881.0 17533.4 17663.6 17704.3 17737.8 17742.0 7914.1 8052.3 8054.4 8068.3 8076.2 7203.1 7310.3 7344.8 7440.7 7524.5 5293.1 5353.0 5378.4 5381.7 5634.1 1405.8 1463.9 1512.3 1518.3 1519.3 862.3 915.3 924.3 935.3 935.6 8297.5 8385.5 8529.6 8533.1 8555.2 799.7 991.5 999.3 1008.8 1012.4 5250.4 5383.2 5497.0 5615.5 5715.5 21410.1 22003.6 22184.3 22476.3 22520.5 21090.8 21509.1 21954.5 22183.7 22209.0 10772.1 11539.8 11567.2 11579.9 11594.5 7994.7 8323.1 8368.6 8472.0 8535.9 18391.6 18943.3 19073.6 19151.6 19279.0 19221.8 19415.7 19641.3 19796.3 20054.4 10322.8 10495.9 10640.9 10655.9 10658.3 13591.9 13948.8 13983.8 13996.2 14009.3 11303.0 11332.0 11464.1 11481.7 11724.6 11084.2 11247.2 11391.5 11423.0 11500.4 10199.9 10353.1 10423.7 10427.1 10455.9 7526.3 7540.2 7634.4 7643.0 7744.2 7526.2 7647.8 7758.8 7803.1 7848.6 03:40:04 INFO - PID 24008 | 03:40:04 INFO - PID 24008 | [#4] prototype.html Cycles:180 Average:5368.00 Median:6020.09 stddev:1483.26 (24.6%) stddev-sans-first:1441.42 03:40:04 INFO - PID 24008 | Values: 484.2 510.2 517.9 521.1 523.9 6066.5 6160.9 6171.5 6206.2 6229.7 5829.7 6034.5 6072.8 6093.5 6111.1 5108.4 5113.0 5137.4 5142.7 5154.8 4801.7 4900.4 5098.8 5101.6 5145.6 4842.3 4861.6 4870.3 4918.2 4925.6 4866.1 4878.1 4902.0 4913.6 4922.9 4381.7 4412.8 4424.7 4431.3 4434.6 5960.6 5983.9 5992.4 6008.8 6031.4 5578.2 5645.2 5646.6 5649.3 5672.3 6301.5 6387.4 6390.2 6393.6 6398.3 4758.4 4770.9 4771.7 4785.5 4795.9 6307.2 6307.7 6436.7 6575.2 6698.0 4880.2 4909.7 4914.7 4938.4 4945.2 4921.0 4962.7 4974.9 4991.8 4993.6 5492.8 5511.9 5513.9 5516.3 5610.8 6342.2 6405.4 6422.4 6423.9 6452.9 1702.5 1728.7 1730.0 1731.9 1732.7 1128.7 1194.6 1197.0 1198.3 1218.6 5496.9 5514.2 5554.5 5568.7 5610.6 6419.8 6437.9 6442.9 6517.3 6549.3 5553.7 5557.8 5600.9 5636.4 5649.7 3425.8 3432.6 3443.8 3453.6 3453.7 6298.7 6320.2 6320.6 6321.2 6340.3 6586.2 6630.6 6677.5 6746.2 6779.6 6125.3 6165.0 6321.3 6337.3 6342.9 5985.4 6330.0 6448.2 6470.1 6523.4 6312.3 6319.6 6347.6 6394.6 6419.3 6044.6 6104.0 6130.4 6161.4 6171.3 4789.0 4839.1 4895.3 4964.9 4965.4 6142.9 6374.7 6380.5 6437.2 6592.3 6294.1 6306.5 6377.6 6379.9 6415.5 6270.8 6360.8 6370.6 6386.0 6416.8 6304.2 6312.5 6322.6 6345.8 6349.3 6464.5 6475.0 6492.0 6503.9 6530.3 6179.6 6241.8 6252.8 6271.3 6280.2 03:40:04 INFO - PID 24008 | 03:40:04 INFO - PID 24008 | [#5] yui.html Cycles:180 Average:25196.47 Median:21610.07 stddev:35916.59 (166.2%) stddev-sans-first:35971.02 03:40:04 INFO - PID 24008 | Values: 903.1 908.7 921.7 926.6 929.0 19533.0 19765.3 20008.1 20244.9 20246.3 18779.9 18921.9 19021.1 19130.2 19192.8 974.6 975.0 985.0 986.7 988.7 968.9 990.5 991.5 995.2 1001.3 1051.4 1052.7 1052.8 1055.6 1058.8 998.4 1053.4 1054.5 1054.7 1056.6 744.5 759.2 759.3 762.2 763.8 20095.8 20292.0 20322.4 20380.8 20386.4 21456.9 21799.0 22388.8 22540.3 22580.7 17589.6 17808.2 18038.0 18176.1 18194.0 3766.3 3770.6 3793.3 3797.7 3800.6 141752.0 142838.0 143409.0 150653.0 153678.0 16756.0 17038.6 17149.8 17160.6 17172.0 31139.0 32212.7 32399.4 32456.7 32635.8 8275.9 8456.1 8560.9 8612.3 8628.1 4207.8 4311.6 4312.1 4320.3 4335.3 5535.0 5623.7 5624.2 5642.5 5644.1 947.9 949.1 963.7 987.7 1002.0 680.2 691.9 696.6 699.6 713.0 10563.6 10827.8 10877.3 11717.2 12327.2 663.7 673.3 683.0 688.8 694.0 5140.5 5189.1 5213.5 5338.4 5343.8 123951.0 124423.0 124844.4 124962.0 125046.0 85140.0 108035.5 113262.4 113452.2 114424.0 92092.0 93097.5 94889.0 97079.5 98169.0 12113.2 12394.9 12496.3 12505.4 12575.6 42774.4 42927.7 43858.6 43974.9 44651.8 56535.0 59685.4 60024.1 60479.7 60609.4 18629.8 19133.9 19186.0 19307.0 19332.4 21763.2 21808.1 21955.6 22100.8 22165.6 19119.9 19342.1 19418.9 19701.0 19734.0 18523.4 18656.6 18717.1 18795.6 19242.7 17504.8 17513.9 17544.7 17673.4 17678.8 12554.0 12744.7 12746.4 12886.2 13082.0 13111.9 13392.7 13473.5 13484.3 13506.2 03:40:04 INFO - PID 24008 | -------- Summary: end -------- 03:40:04 INFO - PID 24008 | 03:40:04 INFO - PID 24008 | 03:40:04 INFO - PID 24008 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost 03:40:04 INFO - PID 24008 | 03:40:04 INFO - TEST-INFO | 24008: exit 0 03:40:04 INFO - TEST-OK | dromaeo_css | took 1112901ms 03:40:04 INFO - TEST-START | kraken 03:40:04 INFO - Initialising browser for kraken test... 03:40:04 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:60337/getInfo.html -profile /tmp/tmp7BzqB0/profile 03:40:04 INFO - TEST-INFO | started process 24390 (/builds/slave/test/build/application/firefox/firefox http://localhost:60337/getInfo.html) 03:40:11 INFO - TEST-INFO | 24390: exit 0 03:40:11 INFO - Browser initialized. 03:40:11 INFO - Running cycle 1/1 for kraken test... 03:40:11 INFO - Using env: {'DISPLAY': ':0', 03:40:11 INFO - 'HOME': '/home/cltbld', 03:40:11 INFO - 'JSGC_DISABLE_POISONING': '1', 03:40:11 INFO - 'LANG': 'en_US.UTF-8', 03:40:11 INFO - 'LANGUAGE': 'en_US:en', 03:40:11 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:40:11 INFO - 'LOGNAME': 'cltbld', 03:40:11 INFO - 'MAIL': '/var/mail/cltbld', 03:40:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:40:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:40:11 INFO - 'MOZ_ACCELERATED': '1', 03:40:11 INFO - 'MOZ_CRASHREPORTER': '1', 03:40:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:11 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:40:11 INFO - 'MOZ_NO_REMOTE': '1', 03:40:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:40:11 INFO - 'MOZ_WEBRENDER': '1', 03:40:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:11 INFO - 'NO_EM_RESTART': '1', 03:40:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:11 INFO - 'PWD': '/builds/slave/test', 03:40:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:40:11 INFO - 'RUST_BACKTRACE': 'full', 03:40:11 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:40:11 INFO - 'SHELL': '/bin/bash', 03:40:11 INFO - 'SHLVL': '1', 03:40:11 INFO - 'TERM': 'linux', 03:40:11 INFO - 'TMOUT': '86400', 03:40:11 INFO - 'USER': 'cltbld', 03:40:11 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1505290513.130544-8439048', 03:40:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:11 INFO - '_': '/tools/buildbot/bin/python'} 03:40:11 INFO - TEST-INFO | started process 24592 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7BzqB0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:40:12 INFO - PID 24592 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:40:12 INFO - PID 24592 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:40:12 INFO - PID 24592 | 03:40:12 INFO - PID 24592 | (/builds/slave/test/build/application/firefox/firefox:24651): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:40:12 INFO - PID 24592 | 03:40:22 INFO - PID 24592 | RSS: Main: 212062208 03:40:22 INFO - PID 24592 | 03:40:25 INFO - PID 24592 | Cycle 1(1): loaded http://localhost:60337/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60337/tests/kraken/driver.html?testName=audio-beat-detection) 03:40:26 INFO - PID 24592 | RSS: Main: 217833472 03:40:26 INFO - PID 24592 | 03:40:29 INFO - PID 24592 | Cycle 1(1): loaded http://localhost:60337/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60337/tests/kraken/driver.html?testName=audio-dft) 03:40:29 INFO - PID 24592 | RSS: Main: 219136000 03:40:29 INFO - PID 24592 | 03:40:32 INFO - PID 24592 | Cycle 1(1): loaded http://localhost:60337/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60337/tests/kraken/driver.html?testName=audio-fft) 03:40:33 INFO - PID 24592 | RSS: Main: 214458368 03:40:33 INFO - PID 24592 | 03:40:35 INFO - PID 24592 | Cycle 1(1): loaded http://localhost:60337/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60337/tests/kraken/driver.html?testName=audio-oscillator) 03:40:36 INFO - PID 24592 | RSS: Main: 213737472 03:40:36 INFO - PID 24592 | 03:40:38 INFO - PID 24592 | Cycle 1(1): loaded http://localhost:60337/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60337/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:40:39 INFO - PID 24592 | RSS: Main: 215343104 03:40:39 INFO - PID 24592 | 03:40:42 INFO - PID 24592 | Cycle 1(1): loaded http://localhost:60337/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60337/tests/kraken/driver.html?testName=imaging-darkroom) 03:40:43 INFO - PID 24592 | RSS: Main: 217636864 03:40:43 INFO - PID 24592 | 03:40:46 INFO - PID 24592 | Cycle 1(1): loaded http://localhost:60337/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60337/tests/kraken/driver.html?testName=imaging-desaturate) 03:40:47 INFO - PID 24592 | RSS: Main: 217960448 03:40:47 INFO - PID 24592 | 03:40:50 INFO - PID 24592 | Cycle 1(1): loaded http://localhost:60337/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60337/tests/kraken/driver.html?testName=json-parse-financial) 03:40:51 INFO - PID 24592 | RSS: Main: 216731648 03:40:51 INFO - PID 24592 | 03:40:52 INFO - PID 24592 | Cycle 1(1): loaded http://localhost:60337/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60337/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:40:53 INFO - PID 24592 | RSS: Main: 217956352 03:40:53 INFO - PID 24592 | 03:40:55 INFO - PID 24592 | Cycle 1(1): loaded http://localhost:60337/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60337/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:40:55 INFO - PID 24592 | RSS: Main: 214495232 03:40:55 INFO - PID 24592 | 03:40:57 INFO - PID 24592 | Cycle 1(1): loaded http://localhost:60337/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60337/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:40:58 INFO - PID 24592 | RSS: Main: 214982656 03:40:58 INFO - PID 24592 | 03:41:01 INFO - PID 24592 | Cycle 1(1): loaded http://localhost:60337/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60337/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:41:01 INFO - PID 24592 | RSS: Main: 214921216 03:41:01 INFO - PID 24592 | 03:41:05 INFO - PID 24592 | Cycle 1(1): loaded http://localhost:60337/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60337/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:41:05 INFO - PID 24592 | RSS: Main: 215621632 03:41:05 INFO - PID 24592 | 03:41:07 INFO - PID 24592 | Cycle 1(1): loaded http://localhost:60337/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60337/tests/kraken/driver.html?testName=ai-astar) 03:41:07 INFO - PID 24592 | RSS: Main: 217423872 03:41:07 INFO - PID 24592 | 03:41:07 INFO - PID 24592 | __start_tp_report 03:41:07 INFO - PID 24592 | _x_x_mozilla_page_load 03:41:07 INFO - PID 24592 | _x_x_mozilla_page_load_details 03:41:07 INFO - PID 24592 | |i|pagename|runs| 03:41:07 INFO - PID 24592 | |0;ai-astar;115;113;111;114;114;117;115;115;110;113 03:41:07 INFO - PID 24592 | |1;audio-beat-detection;121;116;119;116;117;116;149;124;117;118 03:41:07 INFO - PID 24592 | |2;audio-dft;163;166;170;161;165;171;166;174;167;170 03:41:07 INFO - PID 24592 | |3;audio-fft;87;75;80;81;78;77;73;77;74;74 03:41:07 INFO - PID 24592 | |4;audio-oscillator;86;85;89;82;85;88;79;134;87;80 03:41:07 INFO - PID 24592 | |5;imaging-gaussian-blur;114;115;115;120;118;114;114;115;115;111 03:41:07 INFO - PID 24592 | |6;imaging-darkroom;149;149;151;154;147;152;149;148;150;150 03:41:07 INFO - PID 24592 | |7;imaging-desaturate;98;100;95;96;96;95;96;95;94;94 03:41:07 INFO - PID 24592 | |8;json-parse-financial;52;55;55;53;54;54;53;52;52;52 03:41:07 INFO - PID 24592 | |9;json-stringify-tinderbox;43;39;46;38;49;38;41;44;39;38 03:41:07 INFO - PID 24592 | |10;stanford-crypto-aes;77;83;79;75;83;74;75;78;82;75 03:41:07 INFO - PID 24592 | |11;stanford-crypto-ccm;112;123;109;115;130;121;123;120;123;113 03:41:07 INFO - PID 24592 | |12;stanford-crypto-pbkdf2;187;171;173;173;182;177;172;181;178;182 03:41:07 INFO - PID 24592 | |13;stanford-crypto-sha256-iterative;71;66;70;76;67;67;67;68;71;67 03:41:07 INFO - PID 24592 | __end_tp_report 03:41:07 INFO - PID 24592 | __start_cc_report 03:41:07 INFO - PID 24592 | _x_x_mozilla_cycle_collect,963 03:41:07 INFO - PID 24592 | __end_cc_report 03:41:07 INFO - PID 24592 | __startTimestamp1505299267793__endTimestamp 03:41:07 INFO - PID 24592 | 03:41:07 INFO - PID 24592 | ------- Summary: start ------- 03:41:07 INFO - PID 24592 | Number of tests: 14 03:41:07 INFO - PID 24592 | 03:41:07 INFO - PID 24592 | [#0] ai-astar Cycles:10 Average:113.70 Median:114.50 stddev:2.06 (1.8%) stddev-sans-first:2.13 03:41:07 INFO - PID 24592 | Values: 115.0 113.0 111.0 114.0 114.0 117.0 115.0 115.0 110.0 113.0 03:41:07 INFO - PID 24592 | 03:41:07 INFO - PID 24592 | [#1] audio-beat-detection Cycles:10 Average:121.30 Median:118.50 stddev:10.07 (8.5%) stddev-sans-first:10.68 03:41:07 INFO - PID 24592 | Values: 121.0 116.0 119.0 116.0 117.0 116.0 149.0 124.0 117.0 118.0 03:41:07 INFO - PID 24592 | 03:41:07 INFO - PID 24592 | [#2] audio-dft Cycles:10 Average:167.30 Median:168.50 stddev:3.95 (2.3%) stddev-sans-first:3.87 03:41:07 INFO - PID 24592 | Values: 163.0 166.0 170.0 161.0 165.0 171.0 166.0 174.0 167.0 170.0 03:41:07 INFO - PID 24592 | 03:41:07 INFO - PID 24592 | [#3] audio-fft Cycles:10 Average:77.60 Median:77.50 stddev:4.22 (5.4%) stddev-sans-first:2.79 03:41:07 INFO - PID 24592 | Values: 87.0 75.0 80.0 81.0 78.0 77.0 73.0 77.0 74.0 74.0 03:41:07 INFO - PID 24592 | 03:41:07 INFO - PID 24592 | [#4] audio-oscillator Cycles:10 Average:89.50 Median:85.50 stddev:15.98 (18.7%) stddev-sans-first:16.90 03:41:07 INFO - PID 24592 | Values: 86.0 85.0 89.0 82.0 85.0 88.0 79.0 134.0 87.0 80.0 03:41:07 INFO - PID 24592 | 03:41:07 INFO - PID 24592 | [#5] imaging-gaussian-blur Cycles:10 Average:115.10 Median:115.00 stddev:2.42 (2.1%) stddev-sans-first:2.54 03:41:07 INFO - PID 24592 | Values: 114.0 115.0 115.0 120.0 118.0 114.0 114.0 115.0 115.0 111.0 03:41:07 INFO - PID 24592 | 03:41:07 INFO - PID 24592 | [#6] imaging-darkroom Cycles:10 Average:149.90 Median:150.00 stddev:2.02 (1.3%) stddev-sans-first:2.12 03:41:07 INFO - PID 24592 | Values: 149.0 149.0 151.0 154.0 147.0 152.0 149.0 148.0 150.0 150.0 03:41:07 INFO - PID 24592 | 03:41:07 INFO - PID 24592 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:95.50 stddev:1.85 (1.9%) stddev-sans-first:1.80 03:41:07 INFO - PID 24592 | Values: 98.0 100.0 95.0 96.0 96.0 95.0 96.0 95.0 94.0 94.0 03:41:07 INFO - PID 24592 | 03:41:07 INFO - PID 24592 | [#8] json-parse-financial Cycles:10 Average:53.20 Median:53.50 stddev:1.23 (2.3%) stddev-sans-first:1.22 03:41:07 INFO - PID 24592 | Values: 52.0 55.0 55.0 53.0 54.0 54.0 53.0 52.0 52.0 52.0 03:41:07 INFO - PID 24592 | 03:41:07 INFO - PID 24592 | [#9] json-stringify-tinderbox Cycles:10 Average:41.50 Median:42.00 stddev:3.87 (9.2%) stddev-sans-first:4.06 03:41:07 INFO - PID 24592 | Values: 43.0 39.0 46.0 38.0 49.0 38.0 41.0 44.0 39.0 38.0 03:41:07 INFO - PID 24592 | 03:41:07 INFO - PID 24592 | [#10] stanford-crypto-aes Cycles:10 Average:78.10 Median:78.50 stddev:3.51 (4.5%) stddev-sans-first:3.70 03:41:07 INFO - PID 24592 | Values: 77.0 83.0 79.0 75.0 83.0 74.0 75.0 78.0 82.0 75.0 03:41:07 INFO - PID 24592 | 03:41:07 INFO - PID 24592 | [#11] stanford-crypto-ccm Cycles:10 Average:118.90 Median:122.00 stddev:6.45 (5.3%) stddev-sans-first:6.34 03:41:07 INFO - PID 24592 | Values: 112.0 123.0 109.0 115.0 130.0 121.0 123.0 120.0 123.0 113.0 03:41:07 INFO - PID 24592 | 03:41:07 INFO - PID 24592 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.60 Median:179.50 stddev:5.34 (3.0%) stddev-sans-first:4.45 03:41:07 INFO - PID 24592 | Values: 187.0 171.0 173.0 173.0 182.0 177.0 172.0 181.0 178.0 182.0 03:41:07 INFO - PID 24592 | 03:41:07 INFO - PID 24592 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:69.00 stddev:3.06 (4.4%) stddev-sans-first:3.15 03:41:07 INFO - PID 24592 | Values: 71.0 66.0 70.0 76.0 67.0 67.0 67.0 68.0 71.0 67.0 03:41:07 INFO - PID 24592 | -------- Summary: end -------- 03:41:07 INFO - PID 24592 | 03:41:08 INFO - PID 24592 | 03:41:08 INFO - PID 24592 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost 03:41:08 INFO - PID 24592 | 03:41:08 INFO - PID 24592 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:41:08 INFO - TEST-INFO | 24592: exit 0 03:41:08 INFO - TEST-OK | kraken | took 64001ms 03:41:08 INFO - SUITE-END | took 1176s 03:41:09 INFO - Completed test suite (00:19:37) 03:41:09 INFO - javascript benchmark 03:41:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8634.091305938859, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3128.6402063762666, 3150.991682661549, 3152.085895090424, 3155.5582218489417, 3187.82466964317, 6127.724252408641, 6283.183186185795, 6313.337099604544, 6316.336784637604, 6393.4565561927175, 6159.507239420846, 6262.373762623735, 6276.968615156929, 6299.401556852092, 6310.24277086749, 5709.714514274269, 5762.82711518653, 5766.250387449636, 5801.100829371454, 5823.388544202861, 5746.798862039829, 5802.0, 5810.418958104198, 5812.186293918855, 5836.854078648025, 5821.708914554277, 5831.475167234969, 5872.324682661484, 5879.823605291848, 5916.142159386886, 5520.751566179531, 5617.21359009739, 5849.7660093596205, 5855.151003104568, 5910.143029260755, 5282.788688452457, 5738.110592858072, 5831.096180092092, 5836.5914385993, 5865.061590145556, 6175.66033868137, 6223.346548612421, 6362.2365316161895, 6365.872682546323, 6370.044493326038, 6461.12774775404, 6483.7082331295205, 6631.4363279121335, 6722.193336799566, 6727.495437842182, 6788.08360871281, 6854.485913556453, 6854.691538880762, 6861.965690171567, 6862.382385585272, 6121.479674227696, 6206.658633775095, 6262.718177682015, 6344.1435406220035, 6351.587146835487, 6883.242843287235, 6988.720451181997, 7027.754028608974, 7077.5753454792875, 7078.646067696594, 6616.636085015371, 6635.900461493082, 6667.63328016954, 6698.4306333961185, 6705.6982435790505, 6466.321036291121, 6591.110200123018, 6602.1747281589805, 6610.107635469246, 6621.5364924454825, 6563.671816409161, 6590.176227971504, 6594.109795177686, 6602.8349291268105, 6672.766453174213, 6772.695228714621, 6789.796306110825, 6821.522493425512, 6831.04365388846, 6832.385085342343, 5205.635605507654, 5294.364676238799, 5295.973520132375, 5333.439988801198, 5348.812791552277, 4593.54064593538, 4597.241455159861, 4668.743219122981, 4675.392199014174, 4676.088162808288, 5646.689432081275, 5736.282964629421, 5736.827895163152, 5739.8565035874435, 5744.425557444222, 6619.768308109193, 6657.833554161185, 6665.100211471487, 6671.3328667133865, 6675.532712710064, 5723.170140329629, 5728.427157284238, 5737.569682273846, 5793.304803423532, 5804.332501762267, 5792.4497172768515, 5819.243498345273, 5840.29916410025, 5849.151872978395, 5863.442972917566, 6526.771562995273, 6528.836779080466, 6537.738490460423, 6614.338566143347, 6616.66916654175, 6481.837954051187, 6581.9670901647105, 6603.471722262304, 6607.0419789131265, 6616.900746488903, 6356.269029061717, 6367.713452894538, 6369.172007638977, 6372.044193371032, 6407.743690252524, 6602.141721576164, 6640.966795165993, 6647.335266473314, 6713.932860671331, 6717.832054198684, 6708.765193218214, 6775.966120169368, 6805.727770889307, 6836.623985680636, 6839.692213850488, 6332.905006424815, 6428.19647544057, 6463.095166676763, 6484.28672845996, 6599.967000164968, 6415.807525774234, 6417.0, 6424.967875160594, 6426.260979987362, 6431.614103153825, 6351.30135685065, 6356.141920840812, 6363.522735794926, 6371.458426033839, 6374.107624932421, 6510.056041873807, 6643.833904152435, 6651.401373876374, 6714.127163468913, 6731.091302674272, 6210.782622608187, 6333.524985626004, 6374.0, 6389.073584330339, 6495.382938620824], "value": 6108.802898602281, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [851.978700532487, 885.4067774591024, 893.6648756716231, 904.7602385367878, 907.0702529906845, 41582.58417415825, 42176.78911605445, 42359.78820105895, 42601.14797704044, 42708.786456067755, 39638.20723585527, 39851.21413465723, 39878.0, 40166.39750403739, 40283.19433611326, 7044.788656340318, 7060.0468936693405, 7108.360247577717, 7120.038794762692, 7126.608036557987, 7112.751053713121, 7178.533395329313, 7186.928130718678, 7200.027996220521, 7219.711211551558, 7162.104736907887, 7176.533525320838, 7191.928080719204, 7205.639718014105, 7221.675024623904, 7055.964720176392, 7718.575478348716, 7866.252705992922, 7883.935668684711, 7931.920680793233, 7724.266194711493, 7741.651625676858, 7832.412569057344, 7843.529388236724, 7863.882041769378, 38529.61470385316, 38803.61196388056, 38823.61176388228, 38885.0, 39986.0, 3503.316853213624, 3555.7333200010103, 3555.9466608000903, 3556.822158892045, 3558.6085530591613, 32908.6709132908, 32919.83540082284, 33150.33699326024, 33176.6682333176, 33340.0, 5159.974200128975, 5196.844094677166, 5204.0, 5242.213667949838, 5253.028189784902, 186802.0, 188331.0, 188715.0, 188908.99999999863, 190067.0, 49118.508814911394, 49303.260451093265, 49577.75211123993, 49620.25569616459, 49648.0, 51608.0, 51747.48252517502, 51934.0, 52429.475705243225, 52498.0, 15561.0, 15654.45209417665, 15763.290651920692, 15773.0, 15792.684146317239, 12632.557860474839, 12681.365931703378, 12689.428975696115, 12766.68083297925, 12767.936160319325, 14741.484048058266, 14777.187254701095, 14779.704405912036, 14820.0, 15052.72051875581, 5750.7987220447085, 5806.680632565165, 5878.823635290948, 5917.201177841022, 6090.512758979271, 993.8807343118727, 1002.0880998291519, 1012.9493525323704, 1017.6743442098606, 1038.3043360948184, 23408.64887026696, 23449.41376465602, 23460.64809027866, 23494.177703780286, 23636.7636323638, 1108.578740078765, 1109.5007246738837, 1114.509615769059, 1120.8598925134359, 1122.2200570603352, 12249.571265005681, 12351.25892446456, 12351.567695130807, 12408.0, 12470.251784892935, 229199.0, 231720.0, 232290.0, 232359.0, 232531.0, 45489.77255113769, 46783.766081170055, 53371.19943200855, 55004.449955500735, 55785.44214557884, 1440.6110350205595, 1455.4614792526834, 1478.8742956848573, 1481.2001519179737, 1498.2059508460534, 26988.595171072844, 27221.455570888076, 27399.178024659293, 27663.585046224725, 27673.308167295174, 38079.80960095182, 38122.809385952896, 38370.2325953485, 38385.23229535338, 38405.0, 190317.0, 192206.0, 192827.0, 194267.0, 195428.0, 35907.102322441104, 35965.28069438649, 36279.274414511034, 36463.27073458569, 36537.63462365342, 43565.0, 44729.77635111804, 44764.32853507135, 45414.772926135156, 45470.77264613656, 31777.682223178395, 31963.36073278568, 32031.35937281195, 32436.0, 32972.83513582417, 31623.20941976469, 31638.841805790824, 32052.83973580117, 32186.03441896747, 32340.514892277104, 35096.64903350934, 36604.90185294445, 36645.816770915975, 36934.0, 37091.629083708816, 30769.230769230948, 30903.2274193147, 31002.534961975136, 31195.84402077975, 32168.0, 22630.0, 22880.427989300402, 23271.1855085078, 23412.361134721086, 23725.406864828517], "value": 17260.98765209004, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [538.7521739999597, 538.9784408623656, 542.9565634749221, 560.1094260126399, 593.376954198092, 22009.339719808413, 22687.432814179654, 22702.659460108112, 22702.77297227027, 22764.317070487872, 22685.659715104288, 24576.385590360205, 24895.626565601484, 24971.62542561863, 24977.125800596983, 6327.4938004959495, 6412.775552855651, 6460.515461340395, 6466.385693359123, 6495.610263384188, 6349.587276827015, 6435.324290949453, 6465.224173099235, 6474.0, 6478.54650174488, 6278.183836101301, 6436.195475565554, 6583.80248592543, 6601.372869577406, 6606.2733099359275, 6477.352264773508, 6505.251896031969, 6529.183852018497, 6548.967255163718, 6549.639769812658, 6029.336772954972, 6046.0, 6078.635281883101, 6087.1173679816175, 6711.194656641234, 29454.0, 29747.0, 29804.403911921858, 29828.552571711443, 29966.250843728863, 2038.2356616268899, 2073.39871437283, 2073.7718850926385, 2076.9480762980897, 2079.625667379871, 19683.901580492005, 20008.399748007436, 20347.084381202734, 20379.79620203794, 20470.283540076027, 2519.710233323173, 2564.6537717408282, 2591.5076135534187, 2607.4524349886547, 2614.307208589725, 123578.0, 131770.0, 143220.0, 150487.0, 150961.0, 20249.797502025085, 20487.282945097148, 20991.580168396853, 21785.0, 22358.217462388737, 41808.58191418108, 42202.0, 42388.364174537404, 42497.57502424998, 42562.57437425586, 10919.608424799888, 11136.0, 11152.0, 11223.887761122447, 11308.886911130783, 9222.354435189607, 9262.907370926205, 9283.860742088875, 9298.581563829644, 9517.90482095184, 11111.944440277746, 11429.59996400122, 11536.365499897585, 11601.883981160248, 11788.174827761974, 3923.5487918889694, 4262.680298977589, 4295.484541854998, 4334.7399156050105, 4378.978504831656, 948.4641177734558, 961.1541843178098, 973.7955029443755, 974.1524873360222, 980.5244456438621, 18334.633307334047, 18365.81634183668, 18775.0612469376, 18894.811051889305, 18935.0, 1021.8722659667542, 1026.8870424253325, 1041.671873359889, 1044.9895501045044, 1047.272145858621, 10555.683329500127, 10568.894311056945, 10656.946715266375, 10741.83887241692, 10906.890931090587, 448068.0, 457632.0, 462415.0, 465299.0, 467242.0, 107804.0, 112300.0, 112372.43813781043, 112540.0, 112775.43612281886, 1026.8767747870304, 1130.3500487219717, 1140.8003599370077, 1182.0366401382846, 1191.4697959408154, 19782.90108549448, 19879.30422435208, 19893.801061989194, 20397.592048158658, 20527.4868128292, 53361.46638533565, 53866.73066634642, 54223.45776542184, 54784.452155477935, 56027.0, 68869.65565172142, 69096.0, 69787.0, 70212.29787702058, 71677.64161179161, 19147.329843455413, 19603.901980490005, 19811.504712382306, 19902.800971990095, 19954.60090798205, 22045.889770551687, 22379.888100559394, 22381.66427503556, 22461.663075054214, 22518.32445026652, 17903.73144402861, 17945.820541794415, 18018.909905450913, 18025.819741802414, 18036.54908627295, 15813.604659883595, 16477.093759843323, 16480.505584832474, 16726.0, 16844.831551684325, 17022.57443563921, 17984.910075449538, 18210.0, 18558.350457733915, 18596.25614975386, 19175.232990680775, 19203.90398048001, 19229.0, 19271.325503607306, 19355.0, 18010.72983905269, 18043.0, 18104.551635868836, 18106.09469526545, 18193.272269109617], "value": 12666.88797877291, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1327.1042046618534, 1417.5251290817578, 1418.1561970627472, 1431.4703559682919, 1442.1419255542955, 14815.777763333559, 15323.233838308082, 15444.227788610553, 15447.150406727626, 15450.69098618027, 15153.393864245418, 15262.694746105071, 15278.694426111471, 15291.464798732046, 15304.311305991228, 2704.5672692369226, 2726.877290521926, 2772.1129238643643, 2772.5286701260834, 2772.875220615067, 2594.8313359631657, 2687.852168130752, 2689.623452716621, 2698.406350602864, 2706.2557796605893, 2588.7281835407293, 2672.2784848091005, 2756.8483733394655, 2780.457810726909, 2786.749192572668, 2716.8641567921527, 2744.8353098814036, 2747.821391609539, 2771.2656146121194, 2777.722227777216, 2471.480988992296, 2507.5486412445753, 2679.115891755716, 2694.609281654149, 2697.892084316625, 14999.325030373659, 15154.545363639108, 15218.46735364268, 15387.538373848802, 15408.3836646534, 7850.646720897574, 8221.876671849926, 8225.83548329036, 8289.917100828974, 8301.958490207511, 5026.824061157842, 5192.974035129838, 5267.157254839208, 5309.203619457074, 5349.545288650469, 1963.9116239769244, 1965.0960558143272, 1988.6420444320017, 2011.054804242004, 2027.5843452092286, 26782.46435071307, 26957.865210674016, 27054.729452705615, 27068.293170682773, 27080.59379109315, 6514.934850651528, 6633.767818126439, 6737.562058466184, 6763.512027353974, 6880.965595171992, 17533.386331478338, 17663.64672706539, 17704.29182832698, 17737.822621773874, 17742.024188669748, 7914.129445760962, 8052.315553177928, 8054.436189466798, 8068.314193293519, 8076.152004039609, 7203.135623725187, 7310.34206921369, 7344.816379590553, 7440.73957411488, 7524.548527088392, 5293.100172970604, 5353.0, 5378.354597448331, 5381.730913454312, 5634.126710359901, 1405.7680482720236, 1463.8975271730876, 1512.251435539415, 1518.324345666168, 1519.2859356102615, 862.3403096631082, 915.2586405011962, 924.306769922558, 935.3452583191793, 935.6117211357347, 8297.543635100006, 8385.538795366314, 8529.616167272488, 8533.104024077382, 8555.187257210555, 799.7400844725488, 991.548845275398, 999.3004896572428, 1008.7528555503949, 1012.3925644613173, 5250.396204436539, 5383.219433182245, 5497.0, 5615.522680572197, 5715.457031581993, 21410.143594256057, 22003.559928801653, 22184.33446996593, 22476.32571022872, 22520.54958900813, 21090.78909210919, 21509.13963441445, 21954.45113872134, 22183.66724499134, 22209.0, 10772.138228941823, 11539.76920461586, 11567.248128871764, 11579.88420115788, 11594.47824847884, 7994.720184793504, 8323.084460709439, 8368.623411946355, 8471.957640212006, 8535.8719619207, 18391.63216735631, 18943.33698320552, 19073.618527629093, 19151.61696766029, 19279.0, 19221.807781922, 19415.70876436883, 19641.31255406054, 19796.307129250406, 20054.398368048984, 10322.845157322796, 10495.895041049796, 10640.946795266284, 10655.946720266349, 10658.253922225369, 13591.864081359456, 13948.79076813869, 13983.790243146157, 13996.16023038621, 14009.299535023412, 11303.0, 11332.0, 11464.082873370277, 11481.712957176138, 11724.648260552198, 11084.16868734832, 11247.212695111264, 11391.544338226378, 11423.029042531478, 11500.367479788692, 10199.949000254952, 10353.06822385989, 10423.68728938133, 10427.061564459234, 10455.94772026135, 7526.285002924714, 7540.245975402416, 7634.389248859967, 7642.961785191039, 7744.225577442211, 7526.24737526243, 7647.847043059219, 7758.806029849299, 7803.0636323639255, 7848.607569621382], "value": 6760.216200296026, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [484.23490884402645, 510.19898758948466, 517.9378474583049, 521.1167071813276, 523.9083160446922, 6066.452090122149, 6160.876782464348, 6171.506279497647, 6206.162168107304, 6229.719662615182, 5829.650220986733, 6034.547408944336, 6072.846159229754, 6093.482054025402, 6111.075011371415, 5108.4125325587665, 5112.999999999991, 5137.434882162977, 5142.691438513682, 5154.819581314655, 4801.687890287138, 4900.411950565919, 5098.847034588968, 5101.642884998052, 5145.614078944075, 4842.29786680931, 4861.635377346695, 4870.318155458239, 4918.188498897677, 4925.556699897009, 4866.099771542276, 4878.0975519529, 4901.965684241053, 4913.557779799818, 4922.8769280768265, 4381.671374646882, 4412.845550405753, 4424.690271680984, 4431.255589027299, 4434.645228381722, 5960.582759206857, 5983.850403739898, 5992.400759924017, 6008.7896923607905, 6031.396860313934, 5578.163275508666, 5645.23789288449, 5646.57650676201, 5649.265595472562, 5672.347680016768, 6301.495880329563, 6387.361263873622, 6390.233172019341, 6393.584417012879, 6398.29618741938, 4758.405199350082, 4770.880727981794, 4771.665983381165, 4785.521447855222, 4795.880102997418, 6307.180066591313, 6307.7161527730905, 6436.710348034349, 6575.243846957565, 6697.966510167466, 4880.170371036932, 4909.70541767488, 4914.655974081851, 4938.38270216223, 4945.159322915113, 4920.950790492049, 4962.702237865739, 4974.850754477371, 4991.750412479361, 4993.575546078551, 5492.835214943558, 5511.917321240185, 5513.889722205614, 5516.338039435213, 5610.775568977277, 6342.238931328178, 6405.42351188386, 6422.421982021547, 6423.903641445382, 6452.935470645328, 1702.5232934778282, 1728.6888360095052, 1730.0138920815014, 1731.9002433454596, 1732.7141021731525, 1128.7178205448638, 1194.6023152911114, 1196.9700757481132, 1198.3349241171059, 1218.6161359171833, 5496.945030549643, 5514.172874068921, 5554.527865131428, 5568.693721845257, 5610.635308704921, 6419.7802417540515, 6437.871242575216, 6442.871142577123, 6517.250516190604, 6549.312322206195, 5553.666779993213, 5557.777688892399, 5600.915986260209, 5636.408177141423, 5649.689267090267, 3425.828708564562, 3432.553768010143, 3443.776154549946, 3453.6028356738793, 3453.706434953007, 6298.716557754912, 6320.178376810985, 6320.62076275425, 6321.241451025906, 6340.270868850142, 6586.242582103119, 6630.602163870183, 6677.465802735769, 6746.156730408699, 6779.593224406552, 6125.2649682037545, 6164.965561364828, 6321.336259692666, 6337.271213810379, 6342.873142537123, 5985.354027642433, 6329.968350158219, 6448.226212854487, 6470.126532917996, 6523.412892839668, 6312.3056463788025, 6319.557630965788, 6347.5556711029785, 6394.6482943436695, 6419.261784894797, 6044.637321760709, 6104.04670505434, 6130.386961303834, 6161.383861613803, 6171.290301615371, 4789.0, 4839.128956787812, 4895.339129217653, 4964.900701986012, 4965.379327584052, 6142.938570614237, 6374.74501019954, 6380.489560835029, 6437.1631687882145, 6592.274849766618, 6294.087357333253, 6306.46395056407, 6377.649229292433, 6379.936200637934, 6415.486761059011, 6270.843228919313, 6360.777372792115, 6370.649614271074, 6385.96807015962, 6416.7754128605275, 6304.18045654062, 6312.4634406076, 6322.557420980487, 6345.841353966188, 6349.301576826453, 6464.547481676237, 6475.0, 6491.955034164223, 6503.934960650522, 6530.314316996647, 6179.62922224668, 6241.812745617639, 6252.781152659635, 6271.310155882758, 6280.183576135073], "value": 4932.933139234477, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [903.1059251341172, 908.7092130518237, 921.7188757428986, 926.5598840550736, 929.0338048429634, 19533.0, 19765.308214212506, 20008.0996355164, 20244.898775506103, 20246.29137980171, 18779.906100469478, 18921.905390473028, 19021.144048517814, 19130.234790608392, 19192.808071919277, 974.585801034561, 975.0395860077817, 984.9950750246275, 986.7039888033597, 988.6539711101093, 968.9127978481936, 990.529498488216, 991.504247876062, 995.2088089968493, 1001.2940876681922, 1051.3901936876593, 1052.6841947415783, 1052.8052310322576, 1055.551390658967, 1058.7723639417525, 998.3959704378818, 1053.4258828938248, 1054.4991129213602, 1054.6888667842966, 1056.5773690523774, 744.5197847388404, 759.1687102622619, 759.3431681595436, 762.1578156137443, 763.7632333976485, 20095.799042009538, 20292.0, 20322.390328290174, 20380.796192038037, 20386.388408347775, 21456.89271553648, 21799.0, 22388.776112238997, 22540.32379028632, 22580.66129008066, 17589.56026099345, 17808.198631061503, 18038.0, 18176.091195440174, 18193.999330036844, 3766.3408903441787, 3770.6040865709256, 3793.279276937373, 3797.696184305249, 3800.5819359870393, 141752.0, 142838.0, 143409.0, 150653.0, 153678.0, 16756.0, 17038.57403564921, 17149.828501715074, 17160.570985725208, 17172.0, 31139.0, 32212.677873221437, 32399.352012959607, 32456.675433245837, 32635.836820816217, 8275.917240827635, 8456.06983231844, 8560.914390856136, 8612.267957223707, 8628.137186281447, 4207.768572728468, 4311.633511151587, 4312.116016216731, 4320.265554855682, 4335.328024156261, 5535.03136951032, 5623.6906970116215, 5624.21261023457, 5642.520385767174, 5644.125160600031, 947.924166066713, 949.093615597103, 963.7157038673608, 987.693814917378, 1001.9599216031423, 680.2279412866433, 691.9169699636076, 696.5681277607915, 699.618707804248, 712.982175445618, 10563.63027294041, 10827.83758243627, 10877.347359158475, 11717.238379505305, 12327.198732082386, 663.6814329122049, 673.2997682410337, 682.9795106146823, 688.8036909480774, 693.9514234003673, 5140.460251673595, 5189.117849965515, 5213.504717051874, 5338.386085600128, 5343.759530821122, 123951.0, 124423.0, 124844.37577812053, 124962.0, 125046.0, 85140.0, 108035.45982270196, 113262.43368783269, 113452.16369590661, 114424.0, 92092.0, 93097.53451232836, 94889.0, 97079.51460242795, 98169.0, 12113.15207935436, 12394.938025309815, 12496.25022498653, 12505.43725532335, 12575.622731318075, 42774.35838462488, 42927.71216863499, 43858.56141438672, 43974.90062748457, 44651.776741117385, 56535.0, 59685.40314596798, 60024.09963850459, 60479.69760151171, 60609.39390606037, 18629.813701862808, 19133.904330478257, 19186.040697965323, 19307.0, 19332.4200273992, 21763.23828665989, 21808.12767489346, 21955.560888782453, 22100.778992210515, 22165.556688866454, 19119.90440047791, 19342.129604167563, 19418.90290548538, 19701.0, 19734.0, 18523.44429667112, 18656.626867462302, 18717.06414679288, 18795.624087518445, 19242.7113593299, 17504.82495175083, 17513.912430438275, 17544.73682894732, 17673.381431649832, 17678.823211767718, 12554.0, 12744.74510509803, 12746.42641081172, 12886.226826390446, 13082.0, 13111.93444032812, 13392.665183370495, 13473.528426505025, 13484.32578371058, 13506.189628622315], "value": 9300.678080287258, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1468.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 113.0, 111.0, 114.0, 114.0, 117.0, 115.0, 115.0, 110.0, 113.0], "value": 113.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 116.0, 119.0, 116.0, 117.0, 116.0, 149.0, 124.0, 117.0, 118.0], "value": 121.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 166.0, 170.0, 161.0, 165.0, 171.0, 166.0, 174.0, 167.0, 170.0], "value": 167.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 75.0, 80.0, 81.0, 78.0, 77.0, 73.0, 77.0, 74.0, 74.0], "value": 77.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 89.0, 82.0, 85.0, 88.0, 79.0, 134.0, 87.0, 80.0], "value": 89.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 115.0, 120.0, 118.0, 114.0, 114.0, 115.0, 115.0, 111.0], "value": 115.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 151.0, 154.0, 147.0, 152.0, 149.0, 148.0, 150.0, 150.0], "value": 149.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 100.0, 95.0, 96.0, 96.0, 95.0, 96.0, 95.0, 94.0, 94.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 55.0, 55.0, 53.0, 54.0, 54.0, 53.0, 52.0, 52.0, 52.0], "value": 53.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [43.0, 39.0, 46.0, 38.0, 49.0, 38.0, 41.0, 44.0, 39.0, 38.0], "value": 41.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 83.0, 79.0, 75.0, 83.0, 74.0, 75.0, 78.0, 82.0, 75.0], "value": 78.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 123.0, 109.0, 115.0, 130.0, 121.0, 123.0, 120.0, 123.0, 113.0], "value": 118.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 171.0, 173.0, 173.0, 182.0, 177.0, 172.0, 181.0, 178.0, 182.0], "value": 177.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 66.0, 70.0, 76.0, 67.0, 67.0, 67.0, 68.0, 71.0, 67.0], "value": 69.0, "unit": "score"}]}]} 03:41:09 INFO - Return code: 0 03:41:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:41:09 INFO - # TBPL SUCCESS # 03:41:09 INFO - Running post-action listener: _package_coverage_data 03:41:09 INFO - Running post-action listener: _resource_record_post_action 03:41:09 INFO - [mozharness: 2017-09-13 10:41:09.563791Z] Finished run-tests step (success) 03:41:09 INFO - Running post-run listener: _resource_record_post_run 03:41:09 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 12288; Write bytes: 343040000; Read time: 340; Write time: 453496 03:41:09 INFO - TinderboxPrint: CPU usage
13.3% 03:41:09 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 340 03:41:09 INFO - TinderboxPrint: I/O write bytes / time
343,040,000 / 453,496 03:41:09 INFO - TinderboxPrint: CPU idle
8,257.1 (86.7%) 03:41:09 INFO - TinderboxPrint: CPU user
1,201.5 (12.6%) 03:41:09 INFO - TinderboxPrint: Swap in / out
0 / 0 03:41:09 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 13672448; Read time: 0; Write time: 2424 03:41:09 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:41:09 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 8192; Write bytes: 329367552; Read time: 320; Write time: 451072 03:41:10 INFO - Running post-run listener: _upload_blobber_files 03:41:10 INFO - Blob upload gear active. 03:41:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:41:10 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 03:41:10 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'] 03:41:10 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 03:41:10 INFO - (blobuploader) - INFO - Open directory for files ... 03:41:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:41:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:41:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:41:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:41:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:41:11 INFO - (blobuploader) - INFO - Done attempting. 03:41:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:41:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:41:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:41:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:41:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:41:18 INFO - (blobuploader) - INFO - Done attempting. 03:41:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:41:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:41:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:41:19 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:41:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:41:19 INFO - (blobuploader) - INFO - Done attempting. 03:41:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:41:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:41:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:41:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:41:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:41:20 INFO - (blobuploader) - INFO - Done attempting. 03:41:20 INFO - (blobuploader) - INFO - Iteration through files over. 03:41:20 INFO - Return code: 0 03:41:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:41:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:41:20 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/14d20ed499b691fb6def3007082976dc3f2558637ca570f36649bb35769a41864acfcf57be4f5a107349c61d5e74ac1d2194c6662a163641783c576e0095c462", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dfd4ad3561e75cbc3eb9123ba8d5a7afad6c1e688c989a750b2784838badfe4389c7541ff383199d9b62a0565f5ea2f3d1e654d20bb0523fe462b1395a6e9818", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/324dddf0654da64effa2de02d7c3251810bc7d65a5a938aef59c2ca7eba99541af70e3533dbfb46b65f52be8b7e265c632fc878df11f11454d90f91ff4d6f963", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9e2c704680666507f860284a6684372920ec62c3e46fd592125eabf0aab9d2bc2730529fc28cbbd9ba58eb7898b6d7b255385ae3ec4b88a0576ef0f43608f3c2"} 03:41:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:41:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:41:20 INFO - Contents: 03:41:20 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/14d20ed499b691fb6def3007082976dc3f2558637ca570f36649bb35769a41864acfcf57be4f5a107349c61d5e74ac1d2194c6662a163641783c576e0095c462", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dfd4ad3561e75cbc3eb9123ba8d5a7afad6c1e688c989a750b2784838badfe4389c7541ff383199d9b62a0565f5ea2f3d1e654d20bb0523fe462b1395a6e9818", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/324dddf0654da64effa2de02d7c3251810bc7d65a5a938aef59c2ca7eba99541af70e3533dbfb46b65f52be8b7e265c632fc878df11f11454d90f91ff4d6f963", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9e2c704680666507f860284a6684372920ec62c3e46fd592125eabf0aab9d2bc2730529fc28cbbd9ba58eb7898b6d7b255385ae3ec4b88a0576ef0f43608f3c2"} 03:41:20 INFO - Running post-run listener: copy_logs_to_upload_dir 03:41:20 INFO - Copying logs to upload dir... 03:41:20 INFO - mkdir: /builds/slave/test/build/upload/logs 03:41:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.866213 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2017-09-13 03:41:20.694046) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-13 03:41:20.697530) ========= 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=ea65d483da93c827905c2090000001f5-1505290513.130544-8439048 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/14d20ed499b691fb6def3007082976dc3f2558637ca570f36649bb35769a41864acfcf57be4f5a107349c61d5e74ac1d2194c6662a163641783c576e0095c462", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dfd4ad3561e75cbc3eb9123ba8d5a7afad6c1e688c989a750b2784838badfe4389c7541ff383199d9b62a0565f5ea2f3d1e654d20bb0523fe462b1395a6e9818", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/324dddf0654da64effa2de02d7c3251810bc7d65a5a938aef59c2ca7eba99541af70e3533dbfb46b65f52be8b7e265c632fc878df11f11454d90f91ff4d6f963", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9e2c704680666507f860284a6684372920ec62c3e46fd592125eabf0aab9d2bc2730529fc28cbbd9ba58eb7898b6d7b255385ae3ec4b88a0576ef0f43608f3c2"} build_url:https://queue.taskcluster.net/v1/task/TFFNhlJXQAqdPaYDbVW9jw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011278 build_url: 'https://queue.taskcluster.net/v1/task/TFFNhlJXQAqdPaYDbVW9jw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/14d20ed499b691fb6def3007082976dc3f2558637ca570f36649bb35769a41864acfcf57be4f5a107349c61d5e74ac1d2194c6662a163641783c576e0095c462", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dfd4ad3561e75cbc3eb9123ba8d5a7afad6c1e688c989a750b2784838badfe4389c7541ff383199d9b62a0565f5ea2f3d1e654d20bb0523fe462b1395a6e9818", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/324dddf0654da64effa2de02d7c3251810bc7d65a5a938aef59c2ca7eba99541af70e3533dbfb46b65f52be8b7e265c632fc878df11f11454d90f91ff4d6f963", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9e2c704680666507f860284a6684372920ec62c3e46fd592125eabf0aab9d2bc2730529fc28cbbd9ba58eb7898b6d7b255385ae3ec4b88a0576ef0f43608f3c2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-13 03:41:20.725622) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 03:41:20.725936) ========= 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=ea65d483da93c827905c2090000001f5-1505290513.130544-8439048 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004477 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 03:41:20.812042) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-13 03:41:20.812361) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-13 03:41:20.812665) ========= ========= Total master_lag: 0.36 =========