builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-019 starttime: 1506452889.66 results: success (0) revision: 39aaf54972cb11a63815a96b532786133baa95bc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-26 12:08:09.657122) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-26 12:08:09.657609) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-26 12:08:09.657914) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-26 12:08:09.846099) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 12:08:09.846401) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1506452759.584495-1673151166 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-26 12:08:09-- 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% 235M=0s 2017-09-26 12:08:10 (235 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.268871 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 12:08:10.137259) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 12:08:10.137626) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1506452759.584495-1673151166 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014915 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 12:08:10.187752) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 12:08:10.188091) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 39aaf54972cb11a63815a96b532786133baa95bc --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 39aaf54972cb11a63815a96b532786133baa95bc --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=78329bfc0fd5309db0a6e0ac000001b4-1506452759.584495-1673151166 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-26 12:08:10,240 truncating revision to first 12 chars 2017-09-26 12:08:10,240 Setting DEBUG logging. 2017-09-26 12:08:10,240 attempt 1/10 2017-09-26 12:08:10,241 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/39aaf54972cb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-26 12:08:10,632 unpacking tar archive at: mozilla-central-39aaf54972cb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.683719 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 12:08:10.888372) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-26 12:08:10.888751) ========= script_repo_revision: 39aaf54972cb11a63815a96b532786133baa95bc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-26 12:08:10.889187) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-26 12:08:10.889465) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-26 12:08:10.905682) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2017-09-26 12:08:10.906059) ========= /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=78329bfc0fd5309db0a6e0ac000001b4-1506452759.584495-1673151166 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:08:11 INFO - MultiFileLogger online at 20170926 12:08:11 in /builds/slave/test 12:08:11 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 12:08:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:08:11 INFO - {'append_to_log': False, 12:08:11 INFO - 'base_work_dir': '/builds/slave/test', 12:08:11 INFO - 'blob_upload_branch': 'Firefox', 12:08:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:08:11 INFO - 'branch': 'Firefox', 12:08:11 INFO - 'buildbot_json_path': 'buildprops.json', 12:08:11 INFO - 'code_coverage': False, 12:08:11 INFO - 'config_files': ('talos/linux_config.py',), 12:08:11 INFO - 'default_actions': ('clobber', 12:08:11 INFO - 'read-buildbot-config', 12:08:11 INFO - 'download-and-extract', 12:08:11 INFO - 'populate-webroot', 12:08:11 INFO - 'create-virtualenv', 12:08:11 INFO - 'install', 12:08:11 INFO - 'setup-mitmproxy', 12:08:11 INFO - 'run-tests'), 12:08:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:08:11 INFO - 'disable_ccov_upload': False, 12:08:11 INFO - 'disable_stylo': False, 12:08:11 INFO - 'download_minidump_stackwalk': True, 12:08:11 INFO - 'download_symbols': 'ondemand', 12:08:11 INFO - 'enable_stylo': False, 12:08:11 INFO - 'enable_webrender': False, 12:08:11 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 12:08:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:08:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:08:11 INFO - 'gecko_profile': False, 12:08:11 INFO - 'gecko_profile_interval': 0, 12:08:11 INFO - 'installer_path': 'installer.exe', 12:08:11 INFO - 'log_level': 'info', 12:08:11 INFO - 'log_name': 'talos', 12:08:11 INFO - 'log_to_console': True, 12:08:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:08:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:08:11 INFO - 'opt_config_files': (), 12:08:11 INFO - 'pip_index': False, 12:08:11 INFO - 'suite': 'dromaeojs-e10s', 12:08:11 INFO - 'system_bits': '32', 12:08:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:08:11 INFO - 'title': 'talos-linux64-ix-019', 12:08:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:08:11 INFO - 'use_talos_json': True, 12:08:11 INFO - 'verify': 'False', 12:08:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:08:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:08:11 INFO - 'work_dir': 'build'} 12:08:11 INFO - [mozharness: 2017-09-26 19:08:11.097173Z] Running clobber step. 12:08:11 INFO - Running pre-action listener: _resource_record_pre_action 12:08:11 INFO - Running main action method: clobber 12:08:11 INFO - rmtree: /builds/slave/test/build 12:08:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:08:12 INFO - Running post-action listener: _resource_record_post_action 12:08:12 INFO - [mozharness: 2017-09-26 19:08:12.091987Z] Finished clobber step (success) 12:08:12 INFO - [mozharness: 2017-09-26 19:08:12.092085Z] Running read-buildbot-config step. 12:08:12 INFO - Running pre-action listener: _resource_record_pre_action 12:08:12 INFO - Running main action method: read_buildbot_config 12:08:12 INFO - Using buildbot properties: 12:08:12 INFO - { 12:08:12 INFO - "project": "", 12:08:12 INFO - "product": "firefox", 12:08:12 INFO - "who": "ryanvm@gmail.com", 12:08:12 INFO - "installer_path": "public/build/target.tar.bz2", 12:08:12 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 12:08:12 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 12:08:12 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 12:08:12 INFO - "stage_platform": "linux64-qr", 12:08:12 INFO - "basedir": "/builds/slave/test", 12:08:12 INFO - "buildnumber": 85, 12:08:12 INFO - "platform": "ubuntu64_hw_qr", 12:08:12 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 12:08:12 INFO - "slavebuilddir": "test", 12:08:12 INFO - "taskId": "WS5tOpAATdugHk47jVftbw", 12:08:12 INFO - "branch": "mozilla-central", 12:08:12 INFO - "script_repo_revision": "production", 12:08:12 INFO - "revision": "39aaf54972cb11a63815a96b532786133baa95bc", 12:08:12 INFO - "slavename": "talos-linux64-ix-019", 12:08:12 INFO - "repo_path": "mozilla-central" 12:08:12 INFO - } 12:08:12 INFO - Finding installer, test and symbols from parent task. 12:08:12 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WS5tOpAATdugHk47jVftbw'}, attempt #1 12:08:12 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WS5tOpAATdugHk47jVftbw'}, attempt #1 12:08:12 INFO - Task dependencies: CfEmsjFlSySZu2syzfRtJA 12:08:12 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CfEmsjFlSySZu2syzfRtJA'}, attempt #1 12:08:13 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/CfEmsjFlSySZu2syzfRtJA/artifacts/public/build/target.tar.bz2 12:08:13 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/CfEmsjFlSySZu2syzfRtJA/artifacts/public/build/target.test_packages.json 12:08:13 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/CfEmsjFlSySZu2syzfRtJA/artifacts/public/build/target.crashreporter-symbols.zip 12:08:13 INFO - Running post-action listener: _resource_record_post_action 12:08:13 INFO - [mozharness: 2017-09-26 19:08:13.425194Z] Finished read-buildbot-config step (success) 12:08:13 INFO - [mozharness: 2017-09-26 19:08:13.425413Z] Running download-and-extract step. 12:08:13 INFO - Running pre-action listener: _resource_record_pre_action 12:08:13 INFO - Running main action method: download_and_extract 12:08:13 INFO - mkdir: /builds/slave/test/build/tests 12:08: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')]} 12:08:13 INFO - trying https://queue.taskcluster.net/v1/task/CfEmsjFlSySZu2syzfRtJA/artifacts/public/build/target.test_packages.json 12:08:13 INFO - Downloading https://queue.taskcluster.net/v1/task/CfEmsjFlSySZu2syzfRtJA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 12:08:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CfEmsjFlSySZu2syzfRtJA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 12:08:13 INFO - Downloaded 989 bytes. 12:08:13 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 12:08:13 INFO - Using the following test package requirements: 12:08:13 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 12:08:13 INFO - u'common': [u'target.common.tests.zip'], 12:08:13 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 12:08:13 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 12:08:13 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 12:08:13 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 12:08:13 INFO - u'mozbase': [u'target.common.tests.zip'], 12:08:13 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 12:08:13 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 12:08:13 INFO - u'web-platform': [u'target.common.tests.zip', 12:08:13 INFO - u'target.web-platform.tests.tar.gz'], 12:08:13 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 12:08:13 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 12:08:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CfEmsjFlSySZu2syzfRtJA/artifacts/public/build/target.common.tests.zip 12:08:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CfEmsjFlSySZu2syzfRtJA/artifacts/public/build/target.common.tests.zip'}, attempt #1 12:08:13 INFO - Fetch https://queue.taskcluster.net/v1/task/CfEmsjFlSySZu2syzfRtJA/artifacts/public/build/target.common.tests.zip into memory 12:08:15 INFO - Content-Length response header: 54943858 12:08:15 INFO - Bytes received: 54943858 12:08:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CfEmsjFlSySZu2syzfRtJA/artifacts/public/build/target.talos.tests.zip 12:08:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CfEmsjFlSySZu2syzfRtJA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 12:08:25 INFO - Fetch https://queue.taskcluster.net/v1/task/CfEmsjFlSySZu2syzfRtJA/artifacts/public/build/target.talos.tests.zip into memory 12:08:26 INFO - Content-Length response header: 14513823 12:08:26 INFO - Bytes received: 14513823 12:08:26 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')]} 12:08:26 INFO - trying https://queue.taskcluster.net/v1/task/CfEmsjFlSySZu2syzfRtJA/artifacts/public/build/target.tar.bz2 12:08:26 INFO - Downloading https://queue.taskcluster.net/v1/task/CfEmsjFlSySZu2syzfRtJA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 12:08:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CfEmsjFlSySZu2syzfRtJA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 12:08:27 INFO - Downloaded 61626997 bytes. 12:08:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CfEmsjFlSySZu2syzfRtJA/artifacts/public/build/target.tar.bz2 12:08:27 INFO - mkdir: /builds/slave/test/properties 12:08:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:08:27 INFO - Writing to file /builds/slave/test/properties/build_url 12:08:27 INFO - Contents: 12:08:27 INFO - build_url:https://queue.taskcluster.net/v1/task/CfEmsjFlSySZu2syzfRtJA/artifacts/public/build/target.tar.bz2 12:08:27 INFO - Running post-action listener: _resource_record_post_action 12:08:27 INFO - Running post-action listener: find_tests_for_verification 12:08:27 INFO - Running post-action listener: set_extra_try_arguments 12:08:27 INFO - [mozharness: 2017-09-26 19:08:27.803442Z] Finished download-and-extract step (success) 12:08:27 INFO - [mozharness: 2017-09-26 19:08:27.803541Z] Running populate-webroot step. 12:08:27 INFO - Running pre-action listener: _resource_record_pre_action 12:08:27 INFO - Running main action method: populate_webroot 12:08:27 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:08:27 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:08:27 INFO - 'tests': ['tresize', 12:08:27 INFO - 'tcanvasmark']}, 12:08:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:08:27 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:08:27 INFO - 'tests': ['dromaeo_css', 12:08:27 INFO - 'kraken']}, 12:08:27 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 12:08:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:08:27 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 12:08:27 INFO - 'talos_options': ['--disable-stylo'], 12:08:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:08:27 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 12:08:27 INFO - 'tests': ['damp', 'tps']}, 12:08:27 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 12:08:27 INFO - 'talos_options': ['--disable-stylo'], 12:08:27 INFO - 'tests': ['damp', 'tps']}, 12:08:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:08:27 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:08:27 INFO - 'tests': ['dromaeo_dom']}, 12:08:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 12:08:27 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:08:27 INFO - 'tests': ['basic_compositor_video', 12:08:27 INFO - 'glvideo']}, 12:08:27 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 12:08:27 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 12:08:27 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 12:08:27 INFO - 'talos_options': ['--disable-stylo'], 12:08:27 INFO - 'tests': ['ts_paint_webext', 12:08:27 INFO - 'tp5o_webext']}, 12:08:27 INFO - 'other-e10s': {'tests': ['a11yr', 12:08:27 INFO - 'ts_paint', 12:08:27 INFO - 'tpaint', 12:08:27 INFO - 'sessionrestore', 12:08:27 INFO - 'sessionrestore_many_windows', 12:08:27 INFO - 'sessionrestore_no_auto_restore', 12:08:27 INFO - 'tabpaint']}, 12:08:27 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:08:27 INFO - 'tests': ['a11yr', 12:08:27 INFO - 'ts_paint', 12:08:27 INFO - 'tpaint', 12:08:27 INFO - 'sessionrestore', 12:08:27 INFO - 'sessionrestore_many_windows', 12:08:27 INFO - 'sessionrestore_no_auto_restore', 12:08:27 INFO - 'tabpaint']}, 12:08:27 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 12:08:27 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 12:08:27 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:08:27 INFO - 'tests': ['perf_reftest_singletons']}, 12:08:27 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:08:27 INFO - 'tests': ['perf_reftest']}, 12:08:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:08:27 INFO - 'tsvgr_opacity', 12:08:27 INFO - 'tart', 12:08:27 INFO - 'tscrollx', 12:08:27 INFO - 'tsvg_static']}, 12:08:27 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:08:27 INFO - 'tests': ['tsvgx', 12:08:27 INFO - 'tsvgr_opacity', 12:08:27 INFO - 'tart', 12:08:27 INFO - 'tscrollx', 12:08:27 INFO - 'tsvg_static']}, 12:08:27 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 12:08:27 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 12:08:27 INFO - 'talos_options': ['--disable-stylo'], 12:08:27 INFO - 'tests': ['tp5o']}, 12:08:27 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 12:08:27 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 12:08:27 INFO - 'talos_options': ['--mitmproxy', 12:08:27 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 12:08:27 INFO - '--firstNonBlankPaint'], 12:08:27 INFO - 'tests': ['tp6_google', 12:08:27 INFO - 'tp6_youtube', 12:08:27 INFO - 'tp6_amazon', 12:08:27 INFO - 'tp6_facebook']}, 12:08:27 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 12:08:27 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 12:08:27 INFO - 'talos_options': ['--disable-stylo', 12:08:27 INFO - '--mitmproxy', 12:08:27 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 12:08:27 INFO - '--firstNonBlankPaint'], 12:08:27 INFO - 'tests': ['tp6_google', 12:08:27 INFO - 'tp6_youtube', 12:08:27 INFO - 'tp6_amazon', 12:08:27 INFO - 'tp6_facebook']}, 12:08:27 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 12:08:27 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 12:08:27 INFO - 'talos_options': ['--stylo-threads=1', 12:08:27 INFO - '--mitmproxy', 12:08:27 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 12:08:27 INFO - '--firstNonBlankPaint'], 12:08:27 INFO - 'tests': ['tp6_google', 12:08:27 INFO - 'tp6_youtube', 12:08:27 INFO - 'tp6_amazon', 12:08:27 INFO - 'tp6_facebook']}, 12:08:27 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 12:08:27 INFO - 'talos_options': ['--xperf_path', 12:08:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:08:27 INFO - 'tests': ['tp5n']}, 12:08:27 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 12:08:27 INFO - 'talos_options': ['--disable-stylo', 12:08:27 INFO - '--xperf_path', 12:08:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:08:27 INFO - 'tests': ['tp5n']}}} 12:08:27 INFO - Running post-action listener: _resource_record_post_action 12:08:27 INFO - [mozharness: 2017-09-26 19:08:27.819018Z] Finished populate-webroot step (success) 12:08:27 INFO - [mozharness: 2017-09-26 19:08:27.819108Z] Running create-virtualenv step. 12:08:27 INFO - Running pre-action listener: _resource_record_pre_action 12:08:27 INFO - Running main action method: create_virtualenv 12:08:27 INFO - Creating virtualenv /builds/slave/test/build/venv 12:08:27 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 12:08:27 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 12:08:27 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 12:08:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:08:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:08:28 INFO - Installing distribute.............................................................................................................................................................................................done. 12:08:28 INFO - Installing pip...............done. 12:08:28 INFO - Return code: 0 12:08:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:08:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:08:28 INFO - Reading from file tmpfile_stdout 12:08:28 INFO - Output received: 12:08:28 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 12:08:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:08:28 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')]} 12:08:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:08:28 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')]} 12:08:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:08:28 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 0x277d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2945b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aea9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae7d60>, '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 0x2ae8a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae8ef0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1506452759.584495-1673151166', '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 12:08:28 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 12:08:28 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 12:08:28 INFO - Using env: {'DISPLAY': ':0', 12:08:28 INFO - 'HOME': '/home/cltbld', 12:08:28 INFO - 'LANG': 'en_US.UTF-8', 12:08:28 INFO - 'LANGUAGE': 'en_US:en', 12:08:28 INFO - 'LOGNAME': 'cltbld', 12:08:28 INFO - 'MAIL': '/var/mail/cltbld', 12:08:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:08:28 INFO - 'MOZ_NO_REMOTE': '1', 12:08:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:08:28 INFO - 'NO_EM_RESTART': '1', 12:08:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:08:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:08:28 INFO - 'PWD': '/builds/slave/test', 12:08:28 INFO - 'SHELL': '/bin/bash', 12:08:28 INFO - 'SHLVL': '1', 12:08:28 INFO - 'TERM': 'linux', 12:08:28 INFO - 'TMOUT': '86400', 12:08:28 INFO - 'USER': 'cltbld', 12:08:28 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1506452759.584495-1673151166', 12:08:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:08:28 INFO - '_': '/tools/buildbot/bin/python'} 12:08:30 INFO - Ignoring indexes: http://pypi.python.org/simple/ 12:08:30 INFO - Downloading/unpacking pip>=1.5 12:08:30 INFO - Running setup.py egg_info for package pip 12:08:30 INFO - warning: no files found matching 'pip/cacert.pem' 12:08:30 INFO - warning: no files found matching '*.html' under directory 'docs' 12:08:30 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 12:08:30 INFO - no previously-included directories found matching 'docs/_build/_sources' 12:08:30 INFO - Installing collected packages: pip 12:08:30 INFO - Found existing installation: pip 1.1 12:08:30 INFO - Uninstalling pip: 12:08:30 INFO - Successfully uninstalled pip 12:08:30 INFO - Running setup.py install for pip 12:08:30 INFO - warning: no files found matching 'pip/cacert.pem' 12:08:30 INFO - warning: no files found matching '*.html' under directory 'docs' 12:08:30 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 12:08:30 INFO - no previously-included directories found matching 'docs/_build/_sources' 12:08:30 INFO - Installing pip script to /builds/slave/test/build/venv/bin 12:08:30 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 12:08:30 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 12:08:30 INFO - Successfully installed pip 12:08:30 INFO - Cleaning up... 12:08:30 INFO - Return code: 0 12:08:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:08:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:08:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:08:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:08:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:08:30 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 0x277d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2945b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aea9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae7d60>, '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 0x2ae8a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae8ef0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1506452759.584495-1673151166', '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 12:08:30 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 12:08:30 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 12:08:30 INFO - Using env: {'DISPLAY': ':0', 12:08:30 INFO - 'HOME': '/home/cltbld', 12:08:30 INFO - 'LANG': 'en_US.UTF-8', 12:08:30 INFO - 'LANGUAGE': 'en_US:en', 12:08:30 INFO - 'LOGNAME': 'cltbld', 12:08:30 INFO - 'MAIL': '/var/mail/cltbld', 12:08:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:08:30 INFO - 'MOZ_NO_REMOTE': '1', 12:08:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:08:30 INFO - 'NO_EM_RESTART': '1', 12:08:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:08:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:08:30 INFO - 'PWD': '/builds/slave/test', 12:08:30 INFO - 'SHELL': '/bin/bash', 12:08:30 INFO - 'SHLVL': '1', 12:08:30 INFO - 'TERM': 'linux', 12:08:30 INFO - 'TMOUT': '86400', 12:08:30 INFO - 'USER': 'cltbld', 12:08:30 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1506452759.584495-1673151166', 12:08:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:08:30 INFO - '_': '/tools/buildbot/bin/python'} 12:08:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:08:30 INFO - Downloading/unpacking psutil>=3.1.1 12:08:30 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 12:08:30 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 12:08:30 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 12:08:30 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 12:08:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:08:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:08:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:08:31 INFO - Installing collected packages: psutil 12:08:31 INFO - Running setup.py install for psutil 12:08:31 INFO - building 'psutil._psutil_linux' extension 12:08:31 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 12:08:31 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 12:08:31 INFO - building 'psutil._psutil_posix' extension 12:08:31 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 12:08:31 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 12:08:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:08:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:08:32 INFO - Successfully installed psutil 12:08:32 INFO - Cleaning up... 12:08:32 INFO - Return code: 0 12:08:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:08: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')]} 12:08:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:08: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')]} 12:08:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:08:32 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 0x277d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2945b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aea9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae7d60>, '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 0x2ae8a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae8ef0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1506452759.584495-1673151166', '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 12:08:32 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 12:08:32 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 12:08:32 INFO - Using env: {'DISPLAY': ':0', 12:08:32 INFO - 'HOME': '/home/cltbld', 12:08:32 INFO - 'LANG': 'en_US.UTF-8', 12:08:32 INFO - 'LANGUAGE': 'en_US:en', 12:08:32 INFO - 'LOGNAME': 'cltbld', 12:08:32 INFO - 'MAIL': '/var/mail/cltbld', 12:08:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:08:32 INFO - 'MOZ_NO_REMOTE': '1', 12:08:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:08:32 INFO - 'NO_EM_RESTART': '1', 12:08:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:08:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:08:32 INFO - 'PWD': '/builds/slave/test', 12:08:32 INFO - 'SHELL': '/bin/bash', 12:08:32 INFO - 'SHLVL': '1', 12:08:32 INFO - 'TERM': 'linux', 12:08:32 INFO - 'TMOUT': '86400', 12:08:32 INFO - 'USER': 'cltbld', 12:08:32 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1506452759.584495-1673151166', 12:08:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:08:32 INFO - '_': '/tools/buildbot/bin/python'} 12:08:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:08:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:08:32 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 12:08:32 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 12:08:32 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 12:08:32 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 12:08:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:08:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:08:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:08:33 INFO - Installing collected packages: mozsystemmonitor 12:08:33 INFO - Running setup.py install for mozsystemmonitor 12:08:33 INFO - Successfully installed mozsystemmonitor 12:08:33 INFO - Cleaning up... 12:08:34 INFO - Return code: 0 12:08:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:08:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:08:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:08:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:08:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:08:34 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 0x277d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2945b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aea9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae7d60>, '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 0x2ae8a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae8ef0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1506452759.584495-1673151166', '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 12:08:34 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 12:08:34 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 12:08:34 INFO - Using env: {'DISPLAY': ':0', 12:08:34 INFO - 'HOME': '/home/cltbld', 12:08:34 INFO - 'LANG': 'en_US.UTF-8', 12:08:34 INFO - 'LANGUAGE': 'en_US:en', 12:08:34 INFO - 'LOGNAME': 'cltbld', 12:08:34 INFO - 'MAIL': '/var/mail/cltbld', 12:08:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:08:34 INFO - 'MOZ_NO_REMOTE': '1', 12:08:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:08:34 INFO - 'NO_EM_RESTART': '1', 12:08:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:08:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:08:34 INFO - 'PWD': '/builds/slave/test', 12:08:34 INFO - 'SHELL': '/bin/bash', 12:08:34 INFO - 'SHLVL': '1', 12:08:34 INFO - 'TERM': 'linux', 12:08:34 INFO - 'TMOUT': '86400', 12:08:34 INFO - 'USER': 'cltbld', 12:08:34 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1506452759.584495-1673151166', 12:08:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:08:34 INFO - '_': '/tools/buildbot/bin/python'} 12:08:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:08:34 INFO - Downloading/unpacking jsonschema==2.5.1 12:08:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:08:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:08:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:08:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:08:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:08:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:08:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:08:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:08:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:08:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:08:36 INFO - Downloading functools32-3.2.3-2.tar.gz 12:08:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:08:36 INFO - warning: no files found matching '*.txt' 12:08:36 INFO - no previously-included directories found matching 'build' 12:08:36 INFO - no previously-included directories found matching 'dist' 12:08:36 INFO - no previously-included directories found matching '.git*' 12:08:36 INFO - Installing collected packages: jsonschema, functools32 12:08:36 INFO - Running setup.py install for functools32 12:08:36 INFO - warning: no files found matching '*.txt' 12:08:36 INFO - no previously-included directories found matching 'build' 12:08:36 INFO - no previously-included directories found matching 'dist' 12:08:36 INFO - no previously-included directories found matching '.git*' 12:08:36 INFO - Successfully installed jsonschema functools32 12:08:36 INFO - Cleaning up... 12:08:36 INFO - Return code: 0 12:08:36 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:08:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:08:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:08:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:08:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:08:36 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 0x277d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2945b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aea9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae7d60>, '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 0x2ae8a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae8ef0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1506452759.584495-1673151166', '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 12:08:36 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 12:08:36 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 12:08:36 INFO - Using env: {'DISPLAY': ':0', 12:08:36 INFO - 'HOME': '/home/cltbld', 12:08:36 INFO - 'LANG': 'en_US.UTF-8', 12:08:36 INFO - 'LANGUAGE': 'en_US:en', 12:08:36 INFO - 'LOGNAME': 'cltbld', 12:08:36 INFO - 'MAIL': '/var/mail/cltbld', 12:08:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:08:36 INFO - 'MOZ_NO_REMOTE': '1', 12:08:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:08:36 INFO - 'NO_EM_RESTART': '1', 12:08:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:08:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:08:36 INFO - 'PWD': '/builds/slave/test', 12:08:36 INFO - 'SHELL': '/bin/bash', 12:08:36 INFO - 'SHLVL': '1', 12:08:36 INFO - 'TERM': 'linux', 12:08:36 INFO - 'TMOUT': '86400', 12:08:36 INFO - 'USER': 'cltbld', 12:08:36 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1506452759.584495-1673151166', 12:08:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:08:36 INFO - '_': '/tools/buildbot/bin/python'} 12:08:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:08:36 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:08:36 INFO - Cleaning up... 12:08:36 INFO - Return code: 0 12:08:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:08:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:08:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:08:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:08:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:08:36 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 0x277d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2945b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aea9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae7d60>, '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 0x2ae8a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae8ef0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1506452759.584495-1673151166', '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 12:08:36 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 12:08:36 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 12:08:36 INFO - Using env: {'DISPLAY': ':0', 12:08:36 INFO - 'HOME': '/home/cltbld', 12:08:36 INFO - 'LANG': 'en_US.UTF-8', 12:08:36 INFO - 'LANGUAGE': 'en_US:en', 12:08:36 INFO - 'LOGNAME': 'cltbld', 12:08:36 INFO - 'MAIL': '/var/mail/cltbld', 12:08:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:08:36 INFO - 'MOZ_NO_REMOTE': '1', 12:08:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:08:36 INFO - 'NO_EM_RESTART': '1', 12:08:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:08:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:08:36 INFO - 'PWD': '/builds/slave/test', 12:08:36 INFO - 'SHELL': '/bin/bash', 12:08:36 INFO - 'SHLVL': '1', 12:08:36 INFO - 'TERM': 'linux', 12:08:36 INFO - 'TMOUT': '86400', 12:08:36 INFO - 'USER': 'cltbld', 12:08:36 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1506452759.584495-1673151166', 12:08:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:08:36 INFO - '_': '/tools/buildbot/bin/python'} 12:08:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:08:37 INFO - Downloading/unpacking blobuploader==1.2.4 12:08:37 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 12:08:37 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 12:08:37 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 12:08:37 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 12:08:38 INFO - Downloading blobuploader-1.2.4.tar.gz 12:08:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:08:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:08:38 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 12:08:38 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 12:08:38 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 12:08:38 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 12:08:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:08:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:08:38 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 12:08:38 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 12:08:38 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 12:08:38 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 12:08:38 INFO - Downloading docopt-0.6.1.tar.gz 12:08:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:08:38 INFO - Installing collected packages: blobuploader, requests, docopt 12:08:38 INFO - Running setup.py install for blobuploader 12:08:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:08:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:08:38 INFO - Running setup.py install for requests 12:08:39 INFO - Running setup.py install for docopt 12:08:39 INFO - Successfully installed blobuploader requests docopt 12:08:39 INFO - Cleaning up... 12:08:39 INFO - Return code: 0 12:08:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:08:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:08:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:08:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:08:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:08:39 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 0x277d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2945b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aea9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae7d60>, '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 0x2ae8a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae8ef0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1506452759.584495-1673151166', '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 12:08:39 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 12:08:39 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 12:08:39 INFO - Using env: {'DISPLAY': ':0', 12:08:39 INFO - 'HOME': '/home/cltbld', 12:08:39 INFO - 'LANG': 'en_US.UTF-8', 12:08:39 INFO - 'LANGUAGE': 'en_US:en', 12:08:39 INFO - 'LOGNAME': 'cltbld', 12:08:39 INFO - 'MAIL': '/var/mail/cltbld', 12:08:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:08:39 INFO - 'MOZ_NO_REMOTE': '1', 12:08:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:08:39 INFO - 'NO_EM_RESTART': '1', 12:08:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:08:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:08:39 INFO - 'PWD': '/builds/slave/test', 12:08:39 INFO - 'SHELL': '/bin/bash', 12:08:39 INFO - 'SHLVL': '1', 12:08:39 INFO - 'TERM': 'linux', 12:08:39 INFO - 'TMOUT': '86400', 12:08:39 INFO - 'USER': 'cltbld', 12:08:39 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1506452759.584495-1673151166', 12:08:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:08:39 INFO - '_': '/tools/buildbot/bin/python'} 12:08:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:08:39 INFO - Running setup.py (path:/tmp/pip-YmUl1B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:08:39 INFO - Running setup.py (path:/tmp/pip-jKCii_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:08:39 INFO - Running setup.py (path:/tmp/pip-pCfnOL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:08:39 INFO - Running setup.py (path:/tmp/pip-hVDeFm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:08:39 INFO - Running setup.py (path:/tmp/pip-Q3HauP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:08:39 INFO - Running setup.py (path:/tmp/pip-T4Y90y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:08:40 INFO - Running setup.py (path:/tmp/pip-VHDpou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:08:40 INFO - Running setup.py (path:/tmp/pip-uhlPTf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:08:40 INFO - Running setup.py (path:/tmp/pip-iPdsJ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:08:40 INFO - Running setup.py (path:/tmp/pip-btLiTB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:08:40 INFO - Running setup.py (path:/tmp/pip-Dt5imr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:08:40 INFO - Running setup.py (path:/tmp/pip-yICNdh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:08:40 INFO - Running setup.py (path:/tmp/pip-FhyfJG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:08:40 INFO - Running setup.py (path:/tmp/pip-GEkT71-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:08:40 INFO - Running setup.py (path:/tmp/pip-NEMVi2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:08:40 INFO - Running setup.py (path:/tmp/pip-CShA0j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:08:40 INFO - Running setup.py (path:/tmp/pip-gMEIye-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:08:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:08:40 INFO - Running setup.py install for manifestparser 12:08:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:08:40 INFO - Running setup.py install for mozcrash 12:08:40 INFO - Running setup.py install for mozdebug 12:08:41 INFO - Running setup.py install for mozdevice 12:08:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:08:41 INFO - Running setup.py install for mozfile 12:08:41 INFO - Running setup.py install for mozhttpd 12:08:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:08:41 INFO - Running setup.py install for mozinfo 12:08:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:08:41 INFO - Running setup.py install for mozInstall 12:08:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:08:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:08:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:08:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:08:41 INFO - Running setup.py install for mozleak 12:08:41 INFO - Running setup.py install for mozlog 12:08:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:08:41 INFO - Running setup.py install for moznetwork 12:08:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:08:41 INFO - Running setup.py install for mozprocess 12:08:42 INFO - Running setup.py install for mozprofile 12:08:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:08:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:08:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:08:42 INFO - Running setup.py install for mozrunner 12:08:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:08:42 INFO - Running setup.py install for mozscreenshot 12:08:42 INFO - Running setup.py install for moztest 12:08:42 INFO - Running setup.py install for mozversion 12:08:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:08:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:08:42 INFO - Cleaning up... 12:08:42 INFO - Return code: 0 12:08:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:08:42 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')]} 12:08:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:08:42 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')]} 12:08:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:08:42 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 0x277d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2945b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aea9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae7d60>, '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 0x2ae8a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae8ef0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1506452759.584495-1673151166', '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 12:08:42 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 12:08:42 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 12:08:42 INFO - Using env: {'DISPLAY': ':0', 12:08:42 INFO - 'HOME': '/home/cltbld', 12:08:42 INFO - 'LANG': 'en_US.UTF-8', 12:08:42 INFO - 'LANGUAGE': 'en_US:en', 12:08:42 INFO - 'LOGNAME': 'cltbld', 12:08:42 INFO - 'MAIL': '/var/mail/cltbld', 12:08:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:08:42 INFO - 'MOZ_NO_REMOTE': '1', 12:08:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:08:42 INFO - 'NO_EM_RESTART': '1', 12:08:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:08:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:08:42 INFO - 'PWD': '/builds/slave/test', 12:08:42 INFO - 'SHELL': '/bin/bash', 12:08:42 INFO - 'SHLVL': '1', 12:08:42 INFO - 'TERM': 'linux', 12:08:42 INFO - 'TMOUT': '86400', 12:08:42 INFO - 'USER': 'cltbld', 12:08:42 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1506452759.584495-1673151166', 12:08:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:08:42 INFO - '_': '/tools/buildbot/bin/python'} 12:08:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:08:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:08:42 INFO - Running setup.py (path:/tmp/pip-C5fbDb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:08:42 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)) 12:08:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:08:42 INFO - Running setup.py (path:/tmp/pip-KGEF0m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:08:42 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)) 12:08:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:08:42 INFO - Running setup.py (path:/tmp/pip-5hrZgq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:08:43 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)) 12:08:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:08:43 INFO - Running setup.py (path:/tmp/pip-VQFyKO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:08:43 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)) 12:08:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:08:43 INFO - Running setup.py (path:/tmp/pip-EeP52N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:08:43 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)) 12:08:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:08:43 INFO - Running setup.py (path:/tmp/pip-wBvrv0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:08:43 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)) 12:08:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:08:43 INFO - Running setup.py (path:/tmp/pip-WJDFkV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:08:43 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)) 12:08:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:08:43 INFO - Running setup.py (path:/tmp/pip-SBWNxb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:08:43 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)) 12:08:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:08:43 INFO - Running setup.py (path:/tmp/pip-ywqnP1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:08:43 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)) 12:08:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:08:43 INFO - Running setup.py (path:/tmp/pip-rqZjKc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:08:43 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)) 12:08:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:08:43 INFO - Running setup.py (path:/tmp/pip-X1TSUQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:08:43 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)) 12:08:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:08:43 INFO - Running setup.py (path:/tmp/pip-fu8ymS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:08:43 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)) 12:08:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:08:43 INFO - Running setup.py (path:/tmp/pip-tmGj8d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:08:43 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)) 12:08:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:08:43 INFO - Running setup.py (path:/tmp/pip-RKpJD4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:08:43 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)) 12:08:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:08:43 INFO - Running setup.py (path:/tmp/pip-Qu9KXR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:08:43 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)) 12:08:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:08:43 INFO - Running setup.py (path:/tmp/pip-SmNs_C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:08:43 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)) 12:08:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:08:43 INFO - Running setup.py (path:/tmp/pip-rbXBtu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:08:44 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)) 12:08:44 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)) 12:08:44 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)) 12:08:44 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)) 12:08:44 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)) 12:08:44 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)) 12:08:44 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)) 12:08:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:08:44 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 12:08:44 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 12:08:44 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 12:08:44 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 12:08:45 INFO - Downloading blessings-1.6.tar.gz 12:08:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:08:45 INFO - Installing collected packages: blessings 12:08:45 INFO - Running setup.py install for blessings 12:08:45 INFO - Successfully installed blessings 12:08:45 INFO - Cleaning up... 12:08:45 INFO - Return code: 0 12:08:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:08:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:08:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:08:45 INFO - Reading from file tmpfile_stdout 12:08:45 INFO - Current package versions: 12:08:45 INFO - argparse == 1.2.1 12:08:45 INFO - blessings == 1.6 12:08:45 INFO - blobuploader == 1.2.4 12:08:45 INFO - docopt == 0.6.1 12:08:45 INFO - functools32 == 3.2.3-2 12:08:45 INFO - jsonschema == 2.5.1 12:08:45 INFO - manifestparser == 1.1 12:08:45 INFO - mozInstall == 1.13 12:08:45 INFO - mozcrash == 1.0 12:08:45 INFO - mozdebug == 0.1 12:08:45 INFO - mozdevice == 0.51 12:08:45 INFO - mozfile == 1.2 12:08:45 INFO - mozhttpd == 0.7 12:08:45 INFO - mozinfo == 0.10 12:08:45 INFO - mozleak == 0.1 12:08:45 INFO - mozlog == 3.5 12:08:45 INFO - moznetwork == 0.27 12:08:45 INFO - mozprocess == 0.25 12:08:45 INFO - mozprofile == 0.28 12:08:45 INFO - mozrunner == 6.13 12:08:45 INFO - mozscreenshot == 0.1 12:08:45 INFO - mozsystemmonitor == 0.3 12:08:45 INFO - moztest == 0.8 12:08:45 INFO - mozversion == 1.4 12:08:45 INFO - psutil == 3.1.1 12:08:45 INFO - requests == 1.2.3 12:08:45 INFO - wsgiref == 0.1.2 12:08:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:08:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:08:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:08:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:08:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:08:45 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 0x277d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2945b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aea9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae7d60>, '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 0x2ae8a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae8ef0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1506452759.584495-1673151166', '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 12:08:45 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 12:08:45 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 12:08:45 INFO - Using env: {'DISPLAY': ':0', 12:08:45 INFO - 'HOME': '/home/cltbld', 12:08:45 INFO - 'LANG': 'en_US.UTF-8', 12:08:45 INFO - 'LANGUAGE': 'en_US:en', 12:08:45 INFO - 'LOGNAME': 'cltbld', 12:08:45 INFO - 'MAIL': '/var/mail/cltbld', 12:08:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:08:45 INFO - 'MOZ_NO_REMOTE': '1', 12:08:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:08:45 INFO - 'NO_EM_RESTART': '1', 12:08:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:08:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:08:45 INFO - 'PWD': '/builds/slave/test', 12:08:45 INFO - 'SHELL': '/bin/bash', 12:08:45 INFO - 'SHLVL': '1', 12:08:45 INFO - 'TERM': 'linux', 12:08:45 INFO - 'TMOUT': '86400', 12:08:45 INFO - 'USER': 'cltbld', 12:08:45 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1506452759.584495-1673151166', 12:08:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:08:45 INFO - '_': '/tools/buildbot/bin/python'} 12:08:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:08:45 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)) 12:08:45 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)) 12:08:45 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)) 12:08:45 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)) 12:08:45 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)) 12:08:45 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)) 12:08:45 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)) 12:08:45 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)) 12:08:45 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)) 12:08:45 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 12:08:45 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 12:08:45 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 12:08:45 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 12:08:45 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 12:08:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 12:08:47 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)) 12:08:47 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)) 12:08:47 INFO - Installing collected packages: simplejson 12:08:47 INFO - Running setup.py install for simplejson 12:08:47 INFO - building 'simplejson._speedups' extension 12:08:47 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 12:08:48 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 12:08:48 INFO - Successfully installed simplejson 12:08:48 INFO - Cleaning up... 12:08:48 INFO - Return code: 0 12:08:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:08: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')]} 12:08:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:08: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')]} 12:08:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:08:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x277d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2945b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aea9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae7d60>, '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 0x2ae8a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae8ef0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1506452759.584495-1673151166', '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 12:08:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:08:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:08:48 INFO - Using env: {'DISPLAY': ':0', 12:08:48 INFO - 'HOME': '/home/cltbld', 12:08:48 INFO - 'LANG': 'en_US.UTF-8', 12:08:48 INFO - 'LANGUAGE': 'en_US:en', 12:08:48 INFO - 'LOGNAME': 'cltbld', 12:08:48 INFO - 'MAIL': '/var/mail/cltbld', 12:08:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:08:48 INFO - 'MOZ_NO_REMOTE': '1', 12:08:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:08:48 INFO - 'NO_EM_RESTART': '1', 12:08:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:08:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:08:48 INFO - 'PWD': '/builds/slave/test', 12:08:48 INFO - 'SHELL': '/bin/bash', 12:08:48 INFO - 'SHLVL': '1', 12:08:48 INFO - 'TERM': 'linux', 12:08:48 INFO - 'TMOUT': '86400', 12:08:48 INFO - 'USER': 'cltbld', 12:08:48 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1506452759.584495-1673151166', 12:08:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:08:48 INFO - '_': '/tools/buildbot/bin/python'} 12:08:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:08:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:08:48 INFO - Cleaning up... 12:08:48 INFO - Return code: 0 12:08:48 INFO - Running post-action listener: _resource_record_post_action 12:08:48 INFO - Running post-action listener: _start_resource_monitoring 12:08:48 INFO - Starting resource monitoring. 12:08:48 INFO - [mozharness: 2017-09-26 19:08:48.490984Z] Finished create-virtualenv step (success) 12:08:48 INFO - [mozharness: 2017-09-26 19:08:48.491462Z] Running install step. 12:08:48 INFO - Running pre-action listener: _resource_record_pre_action 12:08:48 INFO - Running main action method: install 12:08:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:08:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:08:48 INFO - Reading from file tmpfile_stdout 12:08:48 INFO - Detecting whether we're running mozinstall >=1.0... 12:08:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:08:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:08:48 INFO - Reading from file tmpfile_stdout 12:08:48 INFO - Output received: 12:08:48 INFO - Usage: mozinstall [options] installer 12:08:48 INFO - Options: 12:08:48 INFO - -h, --help show this help message and exit 12:08:48 INFO - -d DEST, --destination=DEST 12:08:48 INFO - Directory to install application into. [default: 12:08:48 INFO - "/builds/slave/test"] 12:08:48 INFO - --app=APP Application being installed. [default: firefox] 12:08:48 INFO - mkdir: /builds/slave/test/build/application 12:08:48 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'] 12:08:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 12:09:07 INFO - Reading from file tmpfile_stdout 12:09:07 INFO - Output received: 12:09:07 INFO - /builds/slave/test/build/application/firefox/firefox 12:09:07 INFO - Running post-action listener: _resource_record_post_action 12:09:07 INFO - [mozharness: 2017-09-26 19:09:07.096367Z] Finished install step (success) 12:09:07 INFO - [mozharness: 2017-09-26 19:09:07.096620Z] Running setup-mitmproxy step. 12:09:07 INFO - Running pre-action listener: _resource_record_pre_action 12:09:07 INFO - Running main action method: setup_mitmproxy 12:09:07 INFO - Skipping: mitmproxy is not required 12:09:07 INFO - Running post-action listener: _resource_record_post_action 12:09:07 INFO - [mozharness: 2017-09-26 19:09:07.097755Z] Finished setup-mitmproxy step (success) 12:09:07 INFO - [mozharness: 2017-09-26 19:09:07.097977Z] Running run-tests step. 12:09:07 INFO - Running pre-action listener: _resource_record_pre_action 12:09:07 INFO - Running pre-action listener: _set_gcov_prefix 12:09:07 INFO - Running main action method: run_tests 12:09:07 WARNING - Try message not found. 12:09:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:09:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:09:07 INFO - Python 2.7.3 12:09:07 INFO - Return code: 0 12:09:07 INFO - grabbing minidump binary from tooltool 12:09: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')]} 12:09:07 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 0x2ae7d60>, '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 0x2ae8a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae8ef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:09:07 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 12:09:07 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 12:09:07 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 12:09:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:09:07 INFO - Return code: 0 12:09:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:09:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:09:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:09:07 INFO - ENV: RUST_BACKTRACE is now full 12:09:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:09:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:09:07 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/CfEmsjFlSySZu2syzfRtJA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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 12:09:07 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/CfEmsjFlSySZu2syzfRtJA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-019 --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 12:09:07 INFO - Using env: {'DISPLAY': ':0', 12:09:07 INFO - 'HOME': '/home/cltbld', 12:09:07 INFO - 'LANG': 'en_US.UTF-8', 12:09:07 INFO - 'LANGUAGE': 'en_US:en', 12:09:07 INFO - 'LOGNAME': 'cltbld', 12:09:07 INFO - 'MAIL': '/var/mail/cltbld', 12:09:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:09:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:09:07 INFO - 'MOZ_ACCELERATED': '1', 12:09:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:09:07 INFO - 'MOZ_NO_REMOTE': '1', 12:09:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:09:07 INFO - 'MOZ_WEBRENDER': '1', 12:09:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:09:07 INFO - 'NO_EM_RESTART': '1', 12:09:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:09:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:09:07 INFO - 'PWD': '/builds/slave/test', 12:09:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:09:07 INFO - 'RUST_BACKTRACE': 'full', 12:09:07 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 12:09:07 INFO - 'SHELL': '/bin/bash', 12:09:07 INFO - 'SHLVL': '1', 12:09:07 INFO - 'TERM': 'linux', 12:09:07 INFO - 'TMOUT': '86400', 12:09:07 INFO - 'USER': 'cltbld', 12:09:07 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1506452759.584495-1673151166', 12:09:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:09:07 INFO - '_': '/tools/buildbot/bin/python'} 12:09:07 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/CfEmsjFlSySZu2syzfRtJA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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 12:09:07 INFO - mozversion application_buildid: 20170926181431 12:09:07 INFO - mozversion application_changeset: 39aaf54972cb11a63815a96b532786133baa95bc 12:09:07 INFO - mozversion application_display_name: Nightly 12:09:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:09:07 INFO - mozversion application_name: Firefox 12:09:07 INFO - mozversion application_remotingname: firefox 12:09:07 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 12:09:07 INFO - mozversion application_vendor: Mozilla 12:09:07 INFO - mozversion application_version: 58.0a1 12:09:07 INFO - mozversion platform_buildid: 20170926181431 12:09:07 INFO - mozversion platform_changeset: 39aaf54972cb11a63815a96b532786133baa95bc 12:09:07 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 12:09:07 INFO - mozversion platform_version: 58.0a1 12:09:07 INFO - using testdate: 1506452947 12:09:07 INFO - actual date: 1506452947 12:09:07 INFO - starting webserver on 'localhost:56606' 12:09:07 INFO - SUITE-START | Running 2 tests 12:09:07 INFO - TEST-START | dromaeo_css 12:09:07 INFO - Initialising browser for dromaeo_css test... 12:09:07 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:56606/getInfo.html -profile /tmp/tmpz0WQ1z/profile 12:09:07 INFO - TEST-INFO | started process 16598 (/builds/slave/test/build/application/firefox/firefox http://localhost:56606/getInfo.html) 12:09:14 INFO - TEST-INFO | 16598: exit 0 12:09:14 INFO - Browser initialized. 12:09:14 INFO - Running cycle 1/1 for dromaeo_css test... 12:09:14 INFO - Using env: {'DISPLAY': ':0', 12:09:14 INFO - 'HOME': '/home/cltbld', 12:09:14 INFO - 'JSGC_DISABLE_POISONING': '1', 12:09:14 INFO - 'LANG': 'en_US.UTF-8', 12:09:14 INFO - 'LANGUAGE': 'en_US:en', 12:09:14 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 12:09:14 INFO - 'LOGNAME': 'cltbld', 12:09:14 INFO - 'MAIL': '/var/mail/cltbld', 12:09:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:09:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:09:14 INFO - 'MOZ_ACCELERATED': '1', 12:09:14 INFO - 'MOZ_CRASHREPORTER': '1', 12:09:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:09:14 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 12:09:14 INFO - 'MOZ_NO_REMOTE': '1', 12:09:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:09:14 INFO - 'MOZ_WEBRENDER': '1', 12:09:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:09:14 INFO - 'NO_EM_RESTART': '1', 12:09:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:09:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:09:14 INFO - 'PWD': '/builds/slave/test', 12:09:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:09:14 INFO - 'RUST_BACKTRACE': 'full', 12:09:14 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 12:09:14 INFO - 'SHELL': '/bin/bash', 12:09:14 INFO - 'SHLVL': '1', 12:09:14 INFO - 'TERM': 'linux', 12:09:14 INFO - 'TMOUT': '86400', 12:09:14 INFO - 'USER': 'cltbld', 12:09:14 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1506452759.584495-1673151166', 12:09:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:09:14 INFO - '_': '/tools/buildbot/bin/python'} 12:09:14 INFO - TEST-INFO | started process 16846 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpz0WQ1z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 12:09:15 INFO - PID 16846 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 12:09:15 INFO - PID 16846 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 12:09:15 INFO - PID 16846 | 12:09:15 INFO - PID 16846 | (/builds/slave/test/build/application/firefox/firefox:16906): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 12:09:15 INFO - PID 16846 | 12:09:26 INFO - PID 16846 | RSS: Main: 203026432 12:09:26 INFO - PID 16846 | 12:12:24 INFO - PID 16846 | Cycle 1(1): loaded http://localhost:56606/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56606/tests/dromaeo/cssquery-ext.html) 12:12:25 INFO - PID 16846 | RSS: Main: 211169280 12:12:25 INFO - PID 16846 | 12:15:27 INFO - PID 16846 | Cycle 1(1): loaded http://localhost:56606/tests/dromaeo/cssquery-ext.html (next: http://localhost:56606/tests/dromaeo/cssquery-jquery.html) 12:15:27 INFO - PID 16846 | RSS: Main: 209264640 12:15:27 INFO - PID 16846 | 12:18:30 INFO - PID 16846 | Cycle 1(1): loaded http://localhost:56606/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56606/tests/dromaeo/cssquery-mootools.html) 12:18:30 INFO - PID 16846 | RSS: Main: 211410944 12:18:30 INFO - PID 16846 | 12:21:32 INFO - PID 16846 | Cycle 1(1): loaded http://localhost:56606/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56606/tests/dromaeo/cssquery-prototype.html) 12:21:33 INFO - PID 16846 | RSS: Main: 210173952 12:21:33 INFO - PID 16846 | 12:24:36 INFO - PID 16846 | Cycle 1(1): loaded http://localhost:56606/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56606/tests/dromaeo/cssquery-yui.html) 12:24:37 INFO - PID 16846 | RSS: Main: 210665472 12:24:37 INFO - PID 16846 | 12:27:39 INFO - PID 16846 | Cycle 1(1): loaded http://localhost:56606/tests/dromaeo/cssquery-yui.html (next: http://localhost:56606/tests/dromaeo/cssquery-dojo.html) 12:27:39 INFO - PID 16846 | RSS: Main: 213610496 12:27:39 INFO - PID 16846 | 12:27:39 INFO - PID 16846 | __start_tp_report 12:27:39 INFO - PID 16846 | _x_x_mozilla_page_load 12:27:39 INFO - PID 16846 | _x_x_mozilla_page_load_details 12:27:39 INFO - PID 16846 | |i|pagename|runs| 12:27:39 INFO - PID 16846 | |0;dojo.html;3090.7836451448397;3136.3100117974036;3136.451121053815;3139.544766008928;3149.2284390324357;6096.542759293048;6209.658468784215;6237.469815065713;6244.531660125492;6330.96834515828;6150.354212807658;6216.409441103099;6325.588836725609;6337.36626337366;6393.648349340784;5764.279465066867;5777;5782.277215348082;5854.73653685583;5896.616719913192;5496.80761173359;5626.184203290521;5795.4784069433745;5856.707164641773;5860.296764388258;5702.600817942745;5707.571932105088;5723.427657234285;5757.1652110444165;5852.9707351463185;5549.139883318052;5569.443055694439;5629.099344104923;5656.91514627281;5667.829965101054;5653.0955047192665;5720.056190728525;5733.111367738007;5744.195812586241;5760.337561180476;6217.502599792051;6258.530610204253;6263.997760358367;6294.559380843343;6345.42891139795;6430.742770289183;6788.524803263774;6793.490488213354;6816.488763342769;6856.897146542806;6675.833104172386;6691.263960964338;6742;6756.797296081126;6759.155105611799;6153.200083989098;6215;6244.438000579969;6247.937520624781;6252.562320637558;7006.4044556212275;7008.859822803515;7025.648717564101;7059.2234854166;7069.187043489962;6612.239592446834;6646.2356828965285;6694.330566943364;6731.091302674175;6732.3267673232285;6519.282878883319;6658.201015878126;6803.387695107365;6881.174259088842;6882.174139103339;6588.505862060365;6703.497237707192;6713.060171575983;6722.294159113223;6773.254941956381;6769.932300677028;6821.3519715626935;6837.35045170708;6839.418649414756;6846.349596788297;5265.315508983807;5316.813911513079;5378.811741589026;5380;5396.136618141157;4530.048689775118;4575.199340115467;4585.449746030497;4606.470255920545;4607.055553611502;5740.598158128891;5810.593258471951;5810.883782324415;5818.796342128006;5841.474267315962;6671.733130674718;6812.625305608239;6843.692033858489;6851.143607049119;6852.28051054642;5713.771449141987;5734.827955161269;5761.596688231783;5808.680522571215;5822.359540450547;5565.860853478695;5688.260526131577;5693.202951586781;5809.8547536311935;5871;6525.967370163214;6549.836254093686;6551.672416379257;6555.410013098844;6570.901436478457;6640.568363056386;6773.356531129535;6804.251532331341;6830.214525329551;6846;6374;6482.416582507597;6488.935110648833;6547.836304092436;6567.868642627025;6420.325865784025;6466.159399278064;6574.901376479453;6667.766628167991;6689.130413046273;6818.045473633596;6819.420349270367;6821.147356580427;6833.384995350442;6845.212800528003;6490.51321150925;6526.216853977553;6533.248676402274;6562.048502967138;6615.239247486601;6518.315576864361;6545.378189072221;6592.307807680125;6606.4384527315715;6639.900401493885;6317.273513546001;6390.48876089921;6418.422341989243;6486.221653401433;6495.707693153725;6574.605523668595;6633.900491492535;6643.46852251809;6644.003399489922;6687.164104486939;6319.2732835722645;6360.872782544416;6370.140031095928;6429.7428102875365;6445.516586255956 12:27:39 INFO - PID 16846 | |1;ext.html;843.8481073406792;859.9871001934971;883.8364902493039;886.268828216721;886.4371124336049;39658.801705991464;39965.40051899224;40376.79811600938;40529.3920591191;40565.79717101418;35861.282774344494;36210.09474763132;39626.20747585047;40706;40747.59252407475;7562.13035500919;7647.158812530617;7667.079950405959;7695.461317707763;7697.499662521918;7489.2510748925215;7599.050118735158;7643.61781910905;7657.655405506738;7691.384689224877;7686.231376862325;7695.807604809868;7725.768226953172;7738.729144479944;7763.534187948713;7617.80955476112;7675.19410461899;7683.193264707237;7685.692572297102;7701.383889288872;7661.808454788619;7689.192634773324;7744.690212391498;7752.069751629784;7761.6507257173;36743.63256367455;36791.63208367935;37013.259734805426;37062.258754824754;37292.62707372946;3475.0269924421204;3485.5643044619424;3490.982545087258;3504.4918486819524;3505.298940211968;30148.69851301481;30465.23836904073;30680.69319306823;30958.53562196569;31061.378772424425;5003.074431230234;5141.820036298749;5189.55888749453;5230.581553475713;5326.201069839516;191185;192236;193201;194806;195139.02430487899;44438.33342499865;44723.329150062775;44756.3286550702;44801.32798008033;44845.103097937856;46819.29771053437;52458.21312680313;53134.46865531295;53138;53301;14759.557213283619;14806.703865922836;14829.258537073103;14833.18417487027;14846.257687115602;12003.279803211835;12011.099167562294;12034.939825300817;12905.677358065936;13226.537071202461;13789.862101379058;13823.308834558433;13965.58103256904;14036;14107.71784564303;5770.394108618619;5803.680797556175;5837.182794408786;5897.702505448794;5918.763249470059;981.2787601113176;987.782687808681;998.1615443027891;1007.385833761388;1040.921930855189;22706.886465567568;22737.204197852996;22741.658875116886;23212.767872321398;23494.64758028631;1099.1424492607468;1113.7494063835734;1118.6140781430393;1121.198343184627;1122.685648018556;12203.572874949512;12238.449269782881;12418.503259869503;12462.43919023646;12487.06347023977;225586;225823;225831;227711;228097;43614.34578481325;43728.56271437309;43937.34093988593;44984.3252351215;45259.32111018337;1412.8916383955338;1413.3216056293038;1448.1238850495508;1448.7609544425052;1450.9637259068609;27041.323966900985;27235.86382068077;27357.86321068382;27505.724942751116;28123.71876281293;36918.44622330721;37048.629513704516;37184.81407592945;37362.43956340603;37381.43927841139;199644;201175;201641;202572;202643;34653;35912.82043589765;35942.460863087595;35951.28097438089;36370.45444318285;42189.1562168761;42383.3642495369;42646.867656617665;42975.785121074194;43535.346969794846;31868.84065579657;32028;32303.838480807444;32391.676083238865;32396.83801580977;31192.688073119887;31278.37443251168;31480.842595786875;32018.51972220372;32026.35947280995;35950.820245898605;36086;36185.45721814122;36320.636793631726;36496.63503364933;29991.250218744706;30146.397072058873;30225.848870756385;30235;30674.846625766728;22782.088716451155;23280.53438931246;23406.18078367249;23868.283951481484;23938.640920386555 12:27:39 INFO - PID 16846 | |2;jquery.html;567.3645517020938;567.860874085849;571.6512927114462;591.7248479457052;606.6481440764355;22198.667019994693;23081.653775193365;23203.535929281403;23212;23299.534009319825;23877.522449550997;24298.878505607492;24433.75566244337;24612;24916.50166996659;6565.606063636185;6720.495962802785;6748.696308666097;6770.661466926658;6783.491238157133;6598.241202261729;6638.103855979453;6695.062691223233;6717.563358381714;6744.887093629545;6082.695865206722;6311.053341998691;6317.905231421532;6349.047642853563;6658.234303055138;6443.097966284724;6472.546921715481;6487.902681459782;6490.221173459192;6491.8052458425855;5970.582059255854;5981.222441082675;6034.879302413927;6034.939650603482;6036;27907.581386279224;28084.297892552644;28142.15573532797;28241.435171296664;28343.433131337257;2090.3310940499046;2112.229036401702;2113.661814109735;2116.301620465258;2124.468882779305;18785;19100.426987190407;19382.612347753107;19475.513112172168;19515.80484195168;2437.792787613055;2468.827182097254;2481.727010028895;2495;2507.949841003188;128255.35872320579;132169.33915330458;132555.33722331424;134797;140168.29915850356;14537.41850325975;14692.898032647381;14693.26533673312;14721.263936803118;14913.03065300752;22030.559388812453;22897.771022289897;22923.42691432694;22971.770282297297;23043.88478057599;9677.70966870995;9725.9027409725;9811.509424528746;9924.40453572788;10002.949690282561;9161.816763664689;9165.679201227926;9189.632414703337;9338.019507951703;9350.625974961062;8647.437916535531;8710.519211734021;8917.331200160013;9019.954900225457;9049.411788233743;2723.167905378384;2840.304125489227;2855.271905664042;2876.6116574262624;2900.6374203224595;960.8126415349079;973.9415635061919;986.5856340337076;987.9851802222972;998.2463240253562;18697.626047478974;19131.521711957314;19220.519487012938;19487.220511179396;19705.901470492558;998.7353351361895;1012.0587853296357;1015.304516406264;1019.4647809899714;1022.4887556221889;10536.630238069156;10651.627193048205;10685.145188384911;10722.463876806129;10807.189460790314;483985;486644;503095;504645;511661;117294.41352793181;117493.4125329385;119619;119770.4011479937;120135;1170.8302296167008;1177.4760231696985;1177.5172179406572;1179.5930404010603;1181.9763604727857;16574.502764917073;16654;16909.577260568585;17012.979221246766;17214.13929303505;46544.53455465402;56915.43084569267;57541.42458575361;59077.40922590719;59748.40251597602;67166.66416667885;67250;67634.66182669056;68251;68280;13977.231252281223;14093.295335233403;14158.787618185941;14219.217943013233;14363.138211707332;21258.25596104129;21709;21875.234366797085;22004.119835206413;22049.448763781034;17415.738763918805;17499.82500174982;17895.10524473797;17959.371422000168;18130.54673633117;15492.922535387252;15622.375104996128;15774.13242271686;16481.752773708642;16494;17004.88979237158;18037.458876233733;18110.81889181144;18156.909215453838;18405.63188736191;13900.51348202808;14057.437702491785;14159.575212743634;14170.07894486855;14226.715465690835;17628.1185940705;17726.645467090842;17735.46793596194;17816.55458613545;17888 12:27:39 INFO - PID 16846 | |3;mootools.html;1285.588611644274;1328.8272524571805;1338.0232430325855;1340.2628554295136;1341.845687745909;15189.924050379746;15696.215189240535;15710.685786284283;15821.60445988848;15830.050196988188;15456.459023934165;15725.84274157258;15762.290696918637;15770.684586308267;15778.21108944554;2702.9459410811774;2736.53478908585;2769.7922655800794;2772.792040596953;2772.9722702772915;2625.1074634624224;2725.305047212958;2727.5772255300462;2728.7816974641983;2733.1253998720417;2477.6531285620026;2594.07910191882;2603.8698065096764;2605.8566778827253;2728.9727102728916;2715.321169707573;2773.4175823077076;2793.594928735322;2797.5663772115354;2809.1432113205565;2718.8912443502236;2731.931701707453;2737.7262273772662;2742.2321749910056;2772.209920172761;15006.249687515581;15209.467668631656;15391.769123463157;15416;15424.305906234134;8176;8346.165383461666;8399.958000210021;8478.06741258461;8481.151884811532;5351.759170837322;5492.423295553949;5585.664860108406;5623.325200975909;5658.66048037115;1860.1164446887756;1899.1928430417156;1905.4950438133906;1931.8357939575153;1939.8157175068486;27508.312292192655;27539.586906196422;27844.025459108834;27871.303217419525;28096.29759256035;7045.68294426752;7093.503454758221;7140.178879428932;7210.387117095106;7281.817954551178;17930.55173620644;17945.371911983017;17960.281588736565;17964.55088622795;17975.73036404455;7656.234376562299;7720.15078341382;7761.107472640719;7776.688932442639;7788.84422311562;7046.43628509718;7138.107736532934;7203.747868824566;7517.699292028367;7651.579163146081;5101.591872650179;5238.580913526908;5285.207218917193;5347.625666203328;5358;1382.198324971514;1418.822647169104;1532.6781375911185;1580.2256894121797;1584.2237303721095;739.5525706947219;871.1375738019316;873.1835733588988;875.3653601139123;889.226373055446;8683.52240626759;8685.131486851264;8705.347098967603;8717.694880679273;8762.605682744292;922.7370199493247;956.9138777510058;957.4351132831663;966.8211380894558;971.4754032822339;5408.810691625853;5549.639273447213;5553.389127196006;5667.09326507765;5798.739056742456;22045.33863984083;22668.319950401514;22778.088876445086;22835.771642283366;23182.072717091465;21145;21780.237691680715;22092.116315347528;22333.10667573279;22790.544189116456;11357.148213883991;11488;11586.47860846247;11592.47833847479;11602.70993225176;7844.882326764989;7869.252421019994;7883.881741773764;7925.524468531907;8031;18331.725024124917;19334.903325483283;19447.70828437603;19566.60866782628;19796.307129250406;18906.338278160198;19198.712019319442;19445.902770486056;19507.21971121196;19956.700649490558;10942.17933654995;11238;11314.886851131383;11315.603953861575;11355.829662554903;13874.583762487142;14210.928945355206;14262.358193881508;14263.928680356532;14313.212773297568;10779.083777878654;11027.558897644325;11056.557737690402;11154.330740155616;11254;11568.652940411801;11682.182247242612;11787.469563869476;11808.822867657163;12055.21641093326;9844.3601165924;9858.408495490006;9861.950690246504;9868.851967220355;9898.604055837686;7470.551766894004;7505.362044226302;7564.546127232384;7571.924280757122;7583.355414789805;7356.117265927909;7382.5570465772225;7430.442716796154;7435.070616172979;7487.812804679927 12:27:39 INFO - PID 16846 | |4;prototype.html;509.236145781328;511.4757373691965;532.4515748778758;532.9253904453379;544.213611331626;6144.907826382602;6296.907010443214;6304.779332723356;6333.746650133995;6343.0802533632595;6010.402042437528;6019.157317975487;6035.939640603593;6126.1009087183;6156.322804491513;5046.6719663221775;5063.772130254148;5083.262926875601;5084.771185296652;5090.211017292326;4915.311856340115;5007.674501157413;5012.573931215851;5057.190849464087;5078.669886457387;4960.941209398095;5006.899862002758;5016.986410871288;5040.722760248185;5048.545630893219;5002.774875130628;5022.6233032522705;5043.218301163325;5047.192449208109;5068.5691716204165;4474.7986340614425;4504.504504504502;4537.478190008125;4547.15877562652;4557.77211139445;6124.152269194846;6138.785142519991;6185.87628247437;6229.190205273331;6239.50083993284;5664.490195882349;5747.166660834156;5782.248307720011;5783.652980821164;5839.182514447981;6431.163948686688;6474.935250647527;6510.1536800216145;6520.380563846427;6629.795610445777;4808.903821923542;4876.804927802884;4895.2167653175675;4918.532739389752;4921.655484116113;6798.66006699663;6867.965660171767;6876.656167191621;6886.8622627547165;6963.537657092017;5040.546350828443;5060.898782024339;5099.898002039939;5105.923411148836;5112.258722485219;5065.772040258197;5090.643654944119;5097.9745101275;5104.770285337168;5116.976604679079;5632.718364081861;5675.687837168913;5699.971500142556;5713.314402271754;5766.769329226868;6350.650714210763;6591.736330546724;6600.966995164993;6665.566738162004;6671.39957403836;1674.9748753768704;1702.9063401513035;1728.1877517566722;1732.8613710903098;1732.9429048280538;1213.9802565844732;1239.3803098450774;1241.3172754984903;1254.084518301645;1259.5906330442642;5557.138643510262;5594.678208543409;5653.830385088454;5687.118496633028;5698.31620205578;6502.382273683992;6603.174603174603;6647.368499992493;6668.099806526154;6714.3957043866285;5602.775888964396;5606.915896261559;5632.915506267327;5681.233033540502;5717.857053573611;3424.8972530824117;3481.8259087045544;3507.4917785352545;3538.2039041216035;3609.729270304738;6420.871582568322;6422.2614399344675;6563.523207278419;6567.408933196035;6596.373344532261;6895.413889819321;6914.135733033371;6919.34266244716;6924.4460443165435;6929.44564434844;6390.392912673288;6447.387498187664;6496.123023391781;6518.315576864551;6551.21385433751;6619;6646.235682896336;6679.966600166968;6702.731890724316;6761.661916904233;6588.736450541925;6659.500537459807;6730.798076057726;6742.393184613408;6749.5612785168805;6398.176519691866;6453.385554567556;6490.48076153916;6520.739170433129;6525.347465253437;4893.241547560134;4977.601791856715;4997.575206107522;5045.192769156917;5056.7471626419265;6594.472442204708;6651.301613330724;6680.565763225375;6695.866082678222;6782.762603308861;6289.119523266655;6397.4562162216735;6415.1981002374705;6489.675516224264;6552.508561857784;6236.906446403398;6279.560430769985;6436.388543088399;6442.581232219891;6486.837829054122;6083.908741368971;6237.7193026314835;6317.652529110943;6338.936610633835;6351.872962540631;6071.696415179312;6462.903056454063;6495.382938620824;6497.628365646599;6522.5760325578685;6206.224221972254;6266.185395898504;6266.216722909637;6333.714982825876;6415.294317624965 12:27:39 INFO - PID 16846 | |5;yui.html;899.5547204133954;900.3112618846579;923.4413180026085;930.2557953637089;936.7283487788542;17622.73565896511;18150.546236344097;18377.724334134964;18399;18493.63012739746;17222.311107555714;17264.48206553802;17506.824931750678;17540.824591754077;17788.377406790732;947.7535840681403;952.200151872427;955.3169483819067;962.0475729028246;962.2302158273388;980.5538479991623;985.4432245781146;986.6201512417734;986.8075725233582;991.6529214774807;986.9161121304697;1019.8266294729914;1031.2523420520101;1032.143321043532;1046.0585473074257;1009.8232809258424;1014.4623349624711;1015.3298822776932;1020.143079812957;1025.118398177563;716.2300526933515;730.1967835381091;731.3198725185575;747.308739416038;748.9026426564566;18342.174602142935;18494;18623.720644190347;18687.71968420475;18803.905980470146;22013.76359992595;22231.888840555694;22827.88586057059;22917.885410573006;23305.417364565852;15656;16033.51899443007;16162.676746465122;16369.345226191057;16385.83614163855;3732.309522738302;3787.8484860605545;3807.9428808567895;3817.1220619257724;3825.1775868188197;141123;142250.28874855558;143893;147008.52991470054;147935;16849.41027064047;16958.576035598962;17256.309747610205;17422.912885435493;17461.563460913578;31894.043178704676;32365;32517.51223731646;32623.836880815445;32752.672473275437;8413.537255450887;8560.400771946028;8572.485650860968;8584.74245772628;8595.140485951355;4141.254574176677;4160.271952408377;4203.642690371292;4215.683823713233;4270.274053410928;5190.429052804188;5272.420033796279;5284.920726189111;5287.127623942007;5302.867428314323;966.8308046092046;978.8384916488842;987.5407935310116;996.6312464388222;1000.46475135802;674.318937872752;680.9727610895509;690.0718533572337;694.9617771022541;695.8677851208254;11122.22144449897;11155.553777848796;11345.319280843176;11397.715057123638;11791.29252244868;622.8941080016408;632.8038308124496;638.3201889987149;643.4080645805869;645.2676212498848;5116.513931176532;5179.326687530597;5199.948000519947;5261.289725887033;5289.68261904287;124926.37536812258;125359;125717.37141314235;126056;130162.34918825346;108248;109162;111034;113187.43406282915;114309;97975;98253.15989386592;99837.50081249548;100016.99983000223;101200.49399752954;9626.32615716893;9626.95186524063;9885.950570247103;9942.751431214278;9962.701118966443;43942;44634.3304850434;44834;46067.76966115148;46237.768811157075;57196.71401642965;57791.422085778606;57895;58248.4175158243;59787;15581.454649087227;15753.212339382755;15788.526344209693;15849.366025358857;15909.761353579937;17350.39273625417;17497.47507574775;17508.037057961934;17518.91240543789;17723.02523361176;14359.425622974964;14383.137011779327;14413.423463061361;14413.78379324332;14690.118592884033;14128.43486260538;14233.074850134708;14279.64300892486;14376.496822611158;14558.854411456174;11676.357800321064;11773.705657358634;11828.645140645795;11836.585719499777;11846.703832403915;10640.467976601294;10903.890961090288;10995.890041099807;11058.889411106107;11117.44412779374;11248.200287953889;11299.774004519699;11390.544378224778;11426.600068997544;11483.425828708698 12:27:39 INFO - PID 16846 | __end_tp_report 12:27:39 INFO - PID 16846 | __start_cc_report 12:27:39 INFO - PID 16846 | _x_x_mozilla_cycle_collect,291 12:27:39 INFO - PID 16846 | __end_cc_report 12:27:39 INFO - PID 16846 | __startTimestamp1506454059756__endTimestamp 12:27:39 INFO - PID 16846 | 12:27:39 INFO - PID 16846 | ------- Summary: start ------- 12:27:39 INFO - PID 16846 | Number of tests: 6 12:27:39 INFO - PID 16846 | 12:27:39 INFO - PID 16846 | [#0] dojo.html Cycles:165 Average:6182.77 Median:6420.33 stddev:762.13 (11.9%) stddev-sans-first:724.84 12:27:39 INFO - PID 16846 | Values: 3090.8 3136.3 3136.5 3139.5 3149.2 6096.5 6209.7 6237.5 6244.5 6331.0 6150.4 6216.4 6325.6 6337.4 6393.6 5764.3 5777.0 5782.3 5854.7 5896.6 5496.8 5626.2 5795.5 5856.7 5860.3 5702.6 5707.6 5723.4 5757.2 5853.0 5549.1 5569.4 5629.1 5656.9 5667.8 5653.1 5720.1 5733.1 5744.2 5760.3 6217.5 6258.5 6264.0 6294.6 6345.4 6430.7 6788.5 6793.5 6816.5 6856.9 6675.8 6691.3 6742.0 6756.8 6759.2 6153.2 6215.0 6244.4 6247.9 6252.6 7006.4 7008.9 7025.6 7059.2 7069.2 6612.2 6646.2 6694.3 6731.1 6732.3 6519.3 6658.2 6803.4 6881.2 6882.2 6588.5 6703.5 6713.1 6722.3 6773.3 6769.9 6821.4 6837.4 6839.4 6846.3 5265.3 5316.8 5378.8 5380.0 5396.1 4530.0 4575.2 4585.4 4606.5 4607.1 5740.6 5810.6 5810.9 5818.8 5841.5 6671.7 6812.6 6843.7 6851.1 6852.3 5713.8 5734.8 5761.6 5808.7 5822.4 5565.9 5688.3 5693.2 5809.9 5871.0 6526.0 6549.8 6551.7 6555.4 6570.9 6640.6 6773.4 6804.3 6830.2 6846.0 6374.0 6482.4 6488.9 6547.8 6567.9 6420.3 6466.2 6574.9 6667.8 6689.1 6818.0 6819.4 6821.1 6833.4 6845.2 6490.5 6526.2 6533.2 6562.0 6615.2 6518.3 6545.4 6592.3 6606.4 6639.9 6317.3 6390.5 6418.4 6486.2 6495.7 6574.6 6633.9 6643.5 6644.0 6687.2 6319.3 6360.9 6370.1 6429.7 6445.5 12:27:39 INFO - PID 16846 | 12:27:39 INFO - PID 16846 | [#1] ext.html Cycles:180 Average:37207.28 Median:35946.64 stddev:53704.89 (149.4%) stddev-sans-first:53786.14 12:27:39 INFO - PID 16846 | Values: 843.8 860.0 883.8 886.3 886.4 39658.8 39965.4 40376.8 40529.4 40565.8 35861.3 36210.1 39626.2 40706.0 40747.6 7562.1 7647.2 7667.1 7695.5 7697.5 7489.3 7599.1 7643.6 7657.7 7691.4 7686.2 7695.8 7725.8 7738.7 7763.5 7617.8 7675.2 7683.2 7685.7 7701.4 7661.8 7689.2 7744.7 7752.1 7761.7 36743.6 36791.6 37013.3 37062.3 37292.6 3475.0 3485.6 3491.0 3504.5 3505.3 30148.7 30465.2 30680.7 30958.5 31061.4 5003.1 5141.8 5189.6 5230.6 5326.2 191185.0 192236.0 193201.0 194806.0 195139.0 44438.3 44723.3 44756.3 44801.3 44845.1 46819.3 52458.2 53134.5 53138.0 53301.0 14759.6 14806.7 14829.3 14833.2 14846.3 12003.3 12011.1 12034.9 12905.7 13226.5 13789.9 13823.3 13965.6 14036.0 14107.7 5770.4 5803.7 5837.2 5897.7 5918.8 981.3 987.8 998.2 1007.4 1040.9 22706.9 22737.2 22741.7 23212.8 23494.6 1099.1 1113.7 1118.6 1121.2 1122.7 12203.6 12238.4 12418.5 12462.4 12487.1 225586.0 225823.0 225831.0 227711.0 228097.0 43614.3 43728.6 43937.3 44984.3 45259.3 1412.9 1413.3 1448.1 1448.8 1451.0 27041.3 27235.9 27357.9 27505.7 28123.7 36918.4 37048.6 37184.8 37362.4 37381.4 199644.0 201175.0 201641.0 202572.0 202643.0 34653.0 35912.8 35942.5 35951.3 36370.5 42189.2 42383.4 42646.9 42975.8 43535.3 31868.8 32028.0 32303.8 32391.7 32396.8 31192.7 31278.4 31480.8 32018.5 32026.4 35950.8 36086.0 36185.5 36320.6 36496.6 29991.3 30146.4 30225.8 30235.0 30674.8 22782.1 23280.5 23406.2 23868.3 23938.6 12:27:39 INFO - PID 16846 | 12:27:39 INFO - PID 16846 | [#2] jquery.html Cycles:180 Average:34558.30 Median:23062.77 stddev:83771.48 (363.2%) stddev-sans-first:83967.61 12:27:39 INFO - PID 16846 | Values: 567.4 567.9 571.7 591.7 606.6 22198.7 23081.7 23203.5 23212.0 23299.5 23877.5 24298.9 24433.8 24612.0 24916.5 6565.6 6720.5 6748.7 6770.7 6783.5 6598.2 6638.1 6695.1 6717.6 6744.9 6082.7 6311.1 6317.9 6349.0 6658.2 6443.1 6472.5 6487.9 6490.2 6491.8 5970.6 5981.2 6034.9 6034.9 6036.0 27907.6 28084.3 28142.2 28241.4 28343.4 2090.3 2112.2 2113.7 2116.3 2124.5 18785.0 19100.4 19382.6 19475.5 19515.8 2437.8 2468.8 2481.7 2495.0 2507.9 128255.4 132169.3 132555.3 134797.0 140168.3 14537.4 14692.9 14693.3 14721.3 14913.0 22030.6 22897.8 22923.4 22971.8 23043.9 9677.7 9725.9 9811.5 9924.4 10002.9 9161.8 9165.7 9189.6 9338.0 9350.6 8647.4 8710.5 8917.3 9020.0 9049.4 2723.2 2840.3 2855.3 2876.6 2900.6 960.8 973.9 986.6 988.0 998.2 18697.6 19131.5 19220.5 19487.2 19705.9 998.7 1012.1 1015.3 1019.5 1022.5 10536.6 10651.6 10685.1 10722.5 10807.2 483985.0 486644.0 503095.0 504645.0 511661.0 117294.4 117493.4 119619.0 119770.4 120135.0 1170.8 1177.5 1177.5 1179.6 1182.0 16574.5 16654.0 16909.6 17013.0 17214.1 46544.5 56915.4 57541.4 59077.4 59748.4 67166.7 67250.0 67634.7 68251.0 68280.0 13977.2 14093.3 14158.8 14219.2 14363.1 21258.3 21709.0 21875.2 22004.1 22049.4 17415.7 17499.8 17895.1 17959.4 18130.5 15492.9 15622.4 15774.1 16481.8 16494.0 17004.9 18037.5 18110.8 18156.9 18405.6 13900.5 14057.4 14159.6 14170.1 14226.7 17628.1 17726.6 17735.5 17816.6 17888.0 12:27:39 INFO - PID 16846 | 12:27:39 INFO - PID 16846 | [#3] mootools.html Cycles:180 Average:9558.97 Median:2728.88 stddev:6930.47 (254.0%) stddev-sans-first:6922.04 12:27:39 INFO - PID 16846 | Values: 1285.6 1328.8 1338.0 1340.3 1341.8 15189.9 15696.2 15710.7 15821.6 15830.1 15456.5 15725.8 15762.3 15770.7 15778.2 2702.9 2736.5 2769.8 2772.8 2773.0 2625.1 2725.3 2727.6 2728.8 2733.1 2477.7 2594.1 2603.9 2605.9 2729.0 2715.3 2773.4 2793.6 2797.6 2809.1 2718.9 2731.9 2737.7 2742.2 2772.2 15006.2 15209.5 15391.8 15416.0 15424.3 8176.0 8346.2 8400.0 8478.1 8481.2 5351.8 5492.4 5585.7 5623.3 5658.7 1860.1 1899.2 1905.5 1931.8 1939.8 27508.3 27539.6 27844.0 27871.3 28096.3 7045.7 7093.5 7140.2 7210.4 7281.8 17930.6 17945.4 17960.3 17964.6 17975.7 7656.2 7720.2 7761.1 7776.7 7788.8 7046.4 7138.1 7203.7 7517.7 7651.6 5101.6 5238.6 5285.2 5347.6 5358.0 1382.2 1418.8 1532.7 1580.2 1584.2 739.6 871.1 873.2 875.4 889.2 8683.5 8685.1 8705.3 8717.7 8762.6 922.7 956.9 957.4 966.8 971.5 5408.8 5549.6 5553.4 5667.1 5798.7 22045.3 22668.3 22778.1 22835.8 23182.1 21145.0 21780.2 22092.1 22333.1 22790.5 11357.1 11488.0 11586.5 11592.5 11602.7 7844.9 7869.3 7883.9 7925.5 8031.0 18331.7 19334.9 19447.7 19566.6 19796.3 18906.3 19198.7 19445.9 19507.2 19956.7 10942.2 11238.0 11314.9 11315.6 11355.8 13874.6 14210.9 14262.4 14263.9 14313.2 10779.1 11027.6 11056.6 11154.3 11254.0 11568.7 11682.2 11787.5 11808.8 12055.2 9844.4 9858.4 9862.0 9868.9 9898.6 7470.6 7505.4 7564.5 7571.9 7583.4 7356.1 7382.6 7430.4 7435.1 7487.8 12:27:39 INFO - PID 16846 | 12:27:39 INFO - PID 16846 | [#4] prototype.html Cycles:180 Average:5495.04 Median:6125.13 stddev:1530.48 (25.0%) stddev-sans-first:1488.32 12:27:39 INFO - PID 16846 | Values: 509.2 511.5 532.5 532.9 544.2 6144.9 6296.9 6304.8 6333.7 6343.1 6010.4 6019.2 6035.9 6126.1 6156.3 5046.7 5063.8 5083.3 5084.8 5090.2 4915.3 5007.7 5012.6 5057.2 5078.7 4960.9 5006.9 5017.0 5040.7 5048.5 5002.8 5022.6 5043.2 5047.2 5068.6 4474.8 4504.5 4537.5 4547.2 4557.8 6124.2 6138.8 6185.9 6229.2 6239.5 5664.5 5747.2 5782.2 5783.7 5839.2 6431.2 6474.9 6510.2 6520.4 6629.8 4808.9 4876.8 4895.2 4918.5 4921.7 6798.7 6868.0 6876.7 6886.9 6963.5 5040.5 5060.9 5099.9 5105.9 5112.3 5065.8 5090.6 5098.0 5104.8 5117.0 5632.7 5675.7 5700.0 5713.3 5766.8 6350.7 6591.7 6601.0 6665.6 6671.4 1675.0 1702.9 1728.2 1732.9 1732.9 1214.0 1239.4 1241.3 1254.1 1259.6 5557.1 5594.7 5653.8 5687.1 5698.3 6502.4 6603.2 6647.4 6668.1 6714.4 5602.8 5606.9 5632.9 5681.2 5717.9 3424.9 3481.8 3507.5 3538.2 3609.7 6420.9 6422.3 6563.5 6567.4 6596.4 6895.4 6914.1 6919.3 6924.4 6929.4 6390.4 6447.4 6496.1 6518.3 6551.2 6619.0 6646.2 6680.0 6702.7 6761.7 6588.7 6659.5 6730.8 6742.4 6749.6 6398.2 6453.4 6490.5 6520.7 6525.3 4893.2 4977.6 4997.6 5045.2 5056.7 6594.5 6651.3 6680.6 6695.9 6782.8 6289.1 6397.5 6415.2 6489.7 6552.5 6236.9 6279.6 6436.4 6442.6 6486.8 6083.9 6237.7 6317.7 6338.9 6351.9 6071.7 6462.9 6495.4 6497.6 6522.6 6206.2 6266.2 6266.2 6333.7 6415.3 12:27:39 INFO - PID 16846 | 12:27:39 INFO - PID 16846 | [#5] yui.html Cycles:180 Average:24439.51 Median:18745.81 stddev:36578.30 (195.1%) stddev-sans-first:36638.21 12:27:39 INFO - PID 16846 | Values: 899.6 900.3 923.4 930.3 936.7 17622.7 18150.5 18377.7 18399.0 18493.6 17222.3 17264.5 17506.8 17540.8 17788.4 947.8 952.2 955.3 962.0 962.2 980.6 985.4 986.6 986.8 991.7 986.9 1019.8 1031.3 1032.1 1046.1 1009.8 1014.5 1015.3 1020.1 1025.1 716.2 730.2 731.3 747.3 748.9 18342.2 18494.0 18623.7 18687.7 18803.9 22013.8 22231.9 22827.9 22917.9 23305.4 15656.0 16033.5 16162.7 16369.3 16385.8 3732.3 3787.8 3807.9 3817.1 3825.2 141123.0 142250.3 143893.0 147008.5 147935.0 16849.4 16958.6 17256.3 17422.9 17461.6 31894.0 32365.0 32517.5 32623.8 32752.7 8413.5 8560.4 8572.5 8584.7 8595.1 4141.3 4160.3 4203.6 4215.7 4270.3 5190.4 5272.4 5284.9 5287.1 5302.9 966.8 978.8 987.5 996.6 1000.5 674.3 681.0 690.1 695.0 695.9 11122.2 11155.6 11345.3 11397.7 11791.3 622.9 632.8 638.3 643.4 645.3 5116.5 5179.3 5199.9 5261.3 5289.7 124926.4 125359.0 125717.4 126056.0 130162.3 108248.0 109162.0 111034.0 113187.4 114309.0 97975.0 98253.2 99837.5 100017.0 101200.5 9626.3 9627.0 9886.0 9942.8 9962.7 43942.0 44634.3 44834.0 46067.8 46237.8 57196.7 57791.4 57895.0 58248.4 59787.0 15581.5 15753.2 15788.5 15849.4 15909.8 17350.4 17497.5 17508.0 17518.9 17723.0 14359.4 14383.1 14413.4 14413.8 14690.1 14128.4 14233.1 14279.6 14376.5 14558.9 11676.4 11773.7 11828.6 11836.6 11846.7 10640.5 10903.9 10995.9 11058.9 11117.4 11248.2 11299.8 11390.5 11426.6 11483.4 12:27:39 INFO - PID 16846 | -------- Summary: end -------- 12:27:39 INFO - PID 16846 | 12:27:40 INFO - TEST-INFO | 16846: exit 0 12:27:40 INFO - TEST-OK | dromaeo_css | took 1113225ms 12:27:40 INFO - TEST-START | kraken 12:27:40 INFO - Initialising browser for kraken test... 12:27:40 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:56606/getInfo.html -profile /tmp/tmpcu8kIS/profile 12:27:40 INFO - TEST-INFO | started process 17236 (/builds/slave/test/build/application/firefox/firefox http://localhost:56606/getInfo.html) 12:27:46 INFO - TEST-INFO | 17236: exit 0 12:27:47 INFO - Browser initialized. 12:27:47 INFO - Running cycle 1/1 for kraken test... 12:27:47 INFO - Using env: {'DISPLAY': ':0', 12:27:47 INFO - 'HOME': '/home/cltbld', 12:27:47 INFO - 'JSGC_DISABLE_POISONING': '1', 12:27:47 INFO - 'LANG': 'en_US.UTF-8', 12:27:47 INFO - 'LANGUAGE': 'en_US:en', 12:27:47 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 12:27:47 INFO - 'LOGNAME': 'cltbld', 12:27:47 INFO - 'MAIL': '/var/mail/cltbld', 12:27:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:27:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:27:47 INFO - 'MOZ_ACCELERATED': '1', 12:27:47 INFO - 'MOZ_CRASHREPORTER': '1', 12:27:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:27:47 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 12:27:47 INFO - 'MOZ_NO_REMOTE': '1', 12:27:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:27:47 INFO - 'MOZ_WEBRENDER': '1', 12:27:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:27:47 INFO - 'NO_EM_RESTART': '1', 12:27:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:27:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:27:47 INFO - 'PWD': '/builds/slave/test', 12:27:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:27:47 INFO - 'RUST_BACKTRACE': 'full', 12:27:47 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 12:27:47 INFO - 'SHELL': '/bin/bash', 12:27:47 INFO - 'SHLVL': '1', 12:27:47 INFO - 'TERM': 'linux', 12:27:47 INFO - 'TMOUT': '86400', 12:27:47 INFO - 'USER': 'cltbld', 12:27:47 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1506452759.584495-1673151166', 12:27:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:27:47 INFO - '_': '/tools/buildbot/bin/python'} 12:27:47 INFO - TEST-INFO | started process 17481 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcu8kIS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 12:27:47 INFO - PID 17481 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 12:27:48 INFO - PID 17481 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 12:27:48 INFO - PID 17481 | 12:27:48 INFO - PID 17481 | (/builds/slave/test/build/application/firefox/firefox:17541): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 12:27:48 INFO - PID 17481 | 12:27:58 INFO - PID 17481 | RSS: Main: 211877888 12:27:58 INFO - PID 17481 | 12:28:01 INFO - PID 17481 | Cycle 1(1): loaded http://localhost:56606/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56606/tests/kraken/driver.html?testName=audio-beat-detection) 12:28:02 INFO - PID 17481 | RSS: Main: 213540864 12:28:02 INFO - PID 17481 | 12:28:05 INFO - PID 17481 | Cycle 1(1): loaded http://localhost:56606/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56606/tests/kraken/driver.html?testName=audio-dft) 12:28:05 INFO - PID 17481 | RSS: Main: 213876736 12:28:05 INFO - PID 17481 | 12:28:08 INFO - PID 17481 | Cycle 1(1): loaded http://localhost:56606/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56606/tests/kraken/driver.html?testName=audio-fft) 12:28:09 INFO - PID 17481 | RSS: Main: 210268160 12:28:09 INFO - PID 17481 | 12:28:11 INFO - PID 17481 | Cycle 1(1): loaded http://localhost:56606/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56606/tests/kraken/driver.html?testName=audio-oscillator) 12:28:12 INFO - PID 17481 | RSS: Main: 210587648 12:28:12 INFO - PID 17481 | 12:28:14 INFO - PID 17481 | Cycle 1(1): loaded http://localhost:56606/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56606/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:28:14 INFO - PID 17481 | RSS: Main: 210661376 12:28:14 INFO - PID 17481 | 12:28:18 INFO - PID 17481 | Cycle 1(1): loaded http://localhost:56606/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56606/tests/kraken/driver.html?testName=imaging-darkroom) 12:28:18 INFO - PID 17481 | RSS: Main: 213106688 12:28:18 INFO - PID 17481 | 12:28:22 INFO - PID 17481 | Cycle 1(1): loaded http://localhost:56606/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56606/tests/kraken/driver.html?testName=imaging-desaturate) 12:28:23 INFO - PID 17481 | RSS: Main: 213614592 12:28:23 INFO - PID 17481 | 12:28:26 INFO - PID 17481 | Cycle 1(1): loaded http://localhost:56606/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56606/tests/kraken/driver.html?testName=json-parse-financial) 12:28:26 INFO - PID 17481 | RSS: Main: 213262336 12:28:26 INFO - PID 17481 | 12:28:28 INFO - PID 17481 | Cycle 1(1): loaded http://localhost:56606/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56606/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:28:29 INFO - PID 17481 | RSS: Main: 214233088 12:28:29 INFO - PID 17481 | 12:28:30 INFO - PID 17481 | Cycle 1(1): loaded http://localhost:56606/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56606/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:28:31 INFO - PID 17481 | RSS: Main: 210595840 12:28:31 INFO - PID 17481 | 12:28:33 INFO - PID 17481 | Cycle 1(1): loaded http://localhost:56606/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56606/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:28:34 INFO - PID 17481 | RSS: Main: 210456576 12:28:34 INFO - PID 17481 | 12:28:36 INFO - PID 17481 | Cycle 1(1): loaded http://localhost:56606/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56606/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:28:37 INFO - PID 17481 | RSS: Main: 210915328 12:28:37 INFO - PID 17481 | 12:28:40 INFO - PID 17481 | Cycle 1(1): loaded http://localhost:56606/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56606/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:28:41 INFO - PID 17481 | RSS: Main: 211701760 12:28:41 INFO - PID 17481 | 12:28:42 INFO - PID 17481 | Cycle 1(1): loaded http://localhost:56606/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56606/tests/kraken/driver.html?testName=ai-astar) 12:28:43 INFO - PID 17481 | RSS: Main: 213590016 12:28:43 INFO - PID 17481 | 12:28:43 INFO - PID 17481 | __start_tp_report 12:28:43 INFO - PID 17481 | _x_x_mozilla_page_load 12:28:43 INFO - PID 17481 | _x_x_mozilla_page_load_details 12:28:43 INFO - PID 17481 | |i|pagename|runs| 12:28:43 INFO - PID 17481 | |0;ai-astar;111;114;110;110;116;116;108;112;109;111 12:28:43 INFO - PID 17481 | |1;audio-beat-detection;121;122;117;126;145;117;126;137;119;118 12:28:43 INFO - PID 17481 | |2;audio-dft;162;165;167;162;173;168;174;162;165;163 12:28:43 INFO - PID 17481 | |3;audio-fft;80;83;78;83;76;74;78;78;81;91 12:28:43 INFO - PID 17481 | |4;audio-oscillator;79;83;83;84;78;90;80;80;84;88 12:28:43 INFO - PID 17481 | |5;imaging-gaussian-blur;117;125;119;114;114;114;114;126;121;116 12:28:43 INFO - PID 17481 | |6;imaging-darkroom;158;150;157;151;148;148;149;160;148;149 12:28:43 INFO - PID 17481 | |7;imaging-desaturate;99;99;101;95;94;97;105;95;96;94 12:28:43 INFO - PID 17481 | |8;json-parse-financial;53;58;52;52;53;54;58;53;51;63 12:28:43 INFO - PID 17481 | |9;json-stringify-tinderbox;39;47;49;38;48;41;38;38;49;43 12:28:43 INFO - PID 17481 | |10;stanford-crypto-aes;76;76;74;77;78;72;82;79;80;76 12:28:43 INFO - PID 17481 | |11;stanford-crypto-ccm;118;119;115;115;119;113;117;116;111;117 12:28:43 INFO - PID 17481 | |12;stanford-crypto-pbkdf2;168;171;178;174;171;181;167;169;166;168 12:28:43 INFO - PID 17481 | |13;stanford-crypto-sha256-iterative;68;77;67;65;67;68;65;65;67;64 12:28:43 INFO - PID 17481 | __end_tp_report 12:28:43 INFO - PID 17481 | __start_cc_report 12:28:43 INFO - PID 17481 | _x_x_mozilla_cycle_collect,752 12:28:43 INFO - PID 17481 | __end_cc_report 12:28:43 INFO - PID 17481 | __startTimestamp1506454123110__endTimestamp 12:28:43 INFO - PID 17481 | 12:28:43 INFO - PID 17481 | ------- Summary: start ------- 12:28:43 INFO - PID 17481 | Number of tests: 14 12:28:43 INFO - PID 17481 | 12:28:43 INFO - PID 17481 | [#0] ai-astar Cycles:10 Average:111.70 Median:111.50 stddev:2.79 (2.5%) stddev-sans-first:2.95 12:28:43 INFO - PID 17481 | Values: 111.0 114.0 110.0 110.0 116.0 116.0 108.0 112.0 109.0 111.0 12:28:43 INFO - PID 17481 | 12:28:43 INFO - PID 17481 | [#1] audio-beat-detection Cycles:10 Average:124.80 Median:124.00 stddev:9.33 (7.5%) stddev-sans-first:9.80 12:28:43 INFO - PID 17481 | Values: 121.0 122.0 117.0 126.0 145.0 117.0 126.0 137.0 119.0 118.0 12:28:43 INFO - PID 17481 | 12:28:43 INFO - PID 17481 | [#2] audio-dft Cycles:10 Average:166.10 Median:166.00 stddev:4.43 (2.7%) stddev-sans-first:4.45 12:28:43 INFO - PID 17481 | Values: 162.0 165.0 167.0 162.0 173.0 168.0 174.0 162.0 165.0 163.0 12:28:43 INFO - PID 17481 | 12:28:43 INFO - PID 17481 | [#3] audio-fft Cycles:10 Average:80.20 Median:80.50 stddev:4.76 (5.9%) stddev-sans-first:5.04 12:28:43 INFO - PID 17481 | Values: 80.0 83.0 78.0 83.0 76.0 74.0 78.0 78.0 81.0 91.0 12:28:43 INFO - PID 17481 | 12:28:43 INFO - PID 17481 | [#4] audio-oscillator Cycles:10 Average:82.90 Median:83.50 stddev:3.87 (4.6%) stddev-sans-first:3.84 12:28:43 INFO - PID 17481 | Values: 79.0 83.0 83.0 84.0 78.0 90.0 80.0 80.0 84.0 88.0 12:28:43 INFO - PID 17481 | 12:28:43 INFO - PID 17481 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:4.62 (3.9%) stddev-sans-first:4.88 12:28:43 INFO - PID 17481 | Values: 117.0 125.0 119.0 114.0 114.0 114.0 114.0 126.0 121.0 116.0 12:28:43 INFO - PID 17481 | 12:28:43 INFO - PID 17481 | [#6] imaging-darkroom Cycles:10 Average:151.80 Median:150.50 stddev:4.66 (3.1%) stddev-sans-first:4.37 12:28:43 INFO - PID 17481 | Values: 158.0 150.0 157.0 151.0 148.0 148.0 149.0 160.0 148.0 149.0 12:28:43 INFO - PID 17481 | 12:28:43 INFO - PID 17481 | [#7] imaging-desaturate Cycles:10 Average:97.50 Median:95.50 stddev:3.54 (3.7%) stddev-sans-first:3.71 12:28:43 INFO - PID 17481 | Values: 99.0 99.0 101.0 95.0 94.0 97.0 105.0 95.0 96.0 94.0 12:28:43 INFO - PID 17481 | 12:28:43 INFO - PID 17481 | [#8] json-parse-financial Cycles:10 Average:54.70 Median:53.50 stddev:3.77 (7.1%) stddev-sans-first:3.95 12:28:43 INFO - PID 17481 | Values: 53.0 58.0 52.0 52.0 53.0 54.0 58.0 53.0 51.0 63.0 12:28:43 INFO - PID 17481 | 12:28:43 INFO - PID 17481 | [#9] json-stringify-tinderbox Cycles:10 Average:43.00 Median:45.00 stddev:4.81 (10.7%) stddev-sans-first:4.88 12:28:43 INFO - PID 17481 | Values: 39.0 47.0 49.0 38.0 48.0 41.0 38.0 38.0 49.0 43.0 12:28:43 INFO - PID 17481 | 12:28:43 INFO - PID 17481 | [#10] stanford-crypto-aes Cycles:10 Average:77.00 Median:77.50 stddev:2.91 (3.7%) stddev-sans-first:3.06 12:28:43 INFO - PID 17481 | Values: 76.0 76.0 74.0 77.0 78.0 72.0 82.0 79.0 80.0 76.0 12:28:43 INFO - PID 17481 | 12:28:43 INFO - PID 17481 | [#11] stanford-crypto-ccm Cycles:10 Average:116.00 Median:117.00 stddev:2.58 (2.2%) stddev-sans-first:2.64 12:28:43 INFO - PID 17481 | Values: 118.0 119.0 115.0 115.0 119.0 113.0 117.0 116.0 111.0 117.0 12:28:43 INFO - PID 17481 | 12:28:43 INFO - PID 17481 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.30 Median:171.00 stddev:4.95 (2.9%) stddev-sans-first:5.10 12:28:43 INFO - PID 17481 | Values: 168.0 171.0 178.0 174.0 171.0 181.0 167.0 169.0 166.0 168.0 12:28:43 INFO - PID 17481 | 12:28:43 INFO - PID 17481 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.00 stddev:3.68 (5.5%) stddev-sans-first:3.90 12:28:43 INFO - PID 17481 | Values: 68.0 77.0 67.0 65.0 67.0 68.0 65.0 65.0 67.0 64.0 12:28:43 INFO - PID 17481 | -------- Summary: end -------- 12:28:43 INFO - PID 17481 | 12:28:43 INFO - PID 17481 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 12:28:44 INFO - TEST-INFO | 17481: exit 0 12:28:44 INFO - TEST-OK | kraken | took 63379ms 12:28:44 INFO - SUITE-END | took 1176s 12:28:44 INFO - Completed test suite (00:19:36) 12:28:44 INFO - javascript benchmark 12:28:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8450.769686806769, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3090.7836451448397, 3136.3100117974036, 3136.451121053815, 3139.544766008928, 3149.2284390324357, 6096.542759293048, 6209.658468784215, 6237.469815065713, 6244.531660125492, 6330.96834515828, 6150.354212807658, 6216.409441103099, 6325.588836725609, 6337.36626337366, 6393.648349340784, 5764.279465066867, 5777.0, 5782.277215348082, 5854.73653685583, 5896.616719913192, 5496.80761173359, 5626.184203290521, 5795.4784069433745, 5856.707164641773, 5860.296764388258, 5702.600817942745, 5707.571932105088, 5723.427657234285, 5757.1652110444165, 5852.9707351463185, 5549.139883318052, 5569.443055694439, 5629.099344104923, 5656.91514627281, 5667.829965101054, 5653.0955047192665, 5720.056190728525, 5733.111367738007, 5744.195812586241, 5760.337561180476, 6217.502599792051, 6258.530610204253, 6263.997760358367, 6294.559380843343, 6345.42891139795, 6430.742770289183, 6788.524803263774, 6793.490488213354, 6816.488763342769, 6856.897146542806, 6675.833104172386, 6691.263960964338, 6742.0, 6756.797296081126, 6759.155105611799, 6153.200083989098, 6215.0, 6244.438000579969, 6247.937520624781, 6252.562320637558, 7006.4044556212275, 7008.859822803515, 7025.648717564101, 7059.2234854166, 7069.187043489962, 6612.239592446834, 6646.2356828965285, 6694.330566943364, 6731.091302674175, 6732.3267673232285, 6519.282878883319, 6658.201015878126, 6803.387695107365, 6881.174259088842, 6882.174139103339, 6588.505862060365, 6703.497237707192, 6713.060171575983, 6722.294159113223, 6773.254941956381, 6769.932300677028, 6821.3519715626935, 6837.35045170708, 6839.418649414756, 6846.349596788297, 5265.315508983807, 5316.813911513079, 5378.811741589026, 5380.0, 5396.136618141157, 4530.048689775118, 4575.199340115467, 4585.449746030497, 4606.470255920545, 4607.055553611502, 5740.598158128891, 5810.593258471951, 5810.883782324415, 5818.796342128006, 5841.474267315962, 6671.733130674718, 6812.625305608239, 6843.692033858489, 6851.143607049119, 6852.28051054642, 5713.771449141987, 5734.827955161269, 5761.596688231783, 5808.680522571215, 5822.359540450547, 5565.860853478695, 5688.260526131577, 5693.202951586781, 5809.8547536311935, 5871.0, 6525.967370163214, 6549.836254093686, 6551.672416379257, 6555.410013098844, 6570.901436478457, 6640.568363056386, 6773.356531129535, 6804.251532331341, 6830.214525329551, 6846.0, 6374.0, 6482.416582507597, 6488.935110648833, 6547.836304092436, 6567.868642627025, 6420.325865784025, 6466.159399278064, 6574.901376479453, 6667.766628167991, 6689.130413046273, 6818.045473633596, 6819.420349270367, 6821.147356580427, 6833.384995350442, 6845.212800528003, 6490.51321150925, 6526.216853977553, 6533.248676402274, 6562.048502967138, 6615.239247486601, 6518.315576864361, 6545.378189072221, 6592.307807680125, 6606.4384527315715, 6639.900401493885, 6317.273513546001, 6390.48876089921, 6418.422341989243, 6486.221653401433, 6495.707693153725, 6574.605523668595, 6633.900491492535, 6643.46852251809, 6644.003399489922, 6687.164104486939, 6319.2732835722645, 6360.872782544416, 6370.140031095928, 6429.7428102875365, 6445.516586255956], "value": 6123.517367542071, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [843.8481073406792, 859.9871001934971, 883.8364902493039, 886.268828216721, 886.4371124336049, 39658.801705991464, 39965.40051899224, 40376.79811600938, 40529.3920591191, 40565.79717101418, 35861.282774344494, 36210.09474763132, 39626.20747585047, 40706.0, 40747.59252407475, 7562.13035500919, 7647.158812530617, 7667.079950405959, 7695.461317707763, 7697.499662521918, 7489.2510748925215, 7599.050118735158, 7643.61781910905, 7657.655405506738, 7691.384689224877, 7686.231376862325, 7695.807604809868, 7725.768226953172, 7738.729144479944, 7763.534187948713, 7617.80955476112, 7675.19410461899, 7683.193264707237, 7685.692572297102, 7701.383889288872, 7661.808454788619, 7689.192634773324, 7744.690212391498, 7752.069751629784, 7761.6507257173, 36743.63256367455, 36791.63208367935, 37013.259734805426, 37062.258754824754, 37292.62707372946, 3475.0269924421204, 3485.5643044619424, 3490.982545087258, 3504.4918486819524, 3505.298940211968, 30148.69851301481, 30465.23836904073, 30680.69319306823, 30958.53562196569, 31061.378772424425, 5003.074431230234, 5141.820036298749, 5189.55888749453, 5230.581553475713, 5326.201069839516, 191185.0, 192236.0, 193201.0, 194806.0, 195139.02430487899, 44438.33342499865, 44723.329150062775, 44756.3286550702, 44801.32798008033, 44845.103097937856, 46819.29771053437, 52458.21312680313, 53134.46865531295, 53138.0, 53301.0, 14759.557213283619, 14806.703865922836, 14829.258537073103, 14833.18417487027, 14846.257687115602, 12003.279803211835, 12011.099167562294, 12034.939825300817, 12905.677358065936, 13226.537071202461, 13789.862101379058, 13823.308834558433, 13965.58103256904, 14036.0, 14107.71784564303, 5770.394108618619, 5803.680797556175, 5837.182794408786, 5897.702505448794, 5918.763249470059, 981.2787601113176, 987.782687808681, 998.1615443027891, 1007.385833761388, 1040.921930855189, 22706.886465567568, 22737.204197852996, 22741.658875116886, 23212.767872321398, 23494.64758028631, 1099.1424492607468, 1113.7494063835734, 1118.6140781430393, 1121.198343184627, 1122.685648018556, 12203.572874949512, 12238.449269782881, 12418.503259869503, 12462.43919023646, 12487.06347023977, 225586.0, 225823.0, 225831.0, 227711.0, 228097.0, 43614.34578481325, 43728.56271437309, 43937.34093988593, 44984.3252351215, 45259.32111018337, 1412.8916383955338, 1413.3216056293038, 1448.1238850495508, 1448.7609544425052, 1450.9637259068609, 27041.323966900985, 27235.86382068077, 27357.86321068382, 27505.724942751116, 28123.71876281293, 36918.44622330721, 37048.629513704516, 37184.81407592945, 37362.43956340603, 37381.43927841139, 199644.0, 201175.0, 201641.0, 202572.0, 202643.0, 34653.0, 35912.82043589765, 35942.460863087595, 35951.28097438089, 36370.45444318285, 42189.1562168761, 42383.3642495369, 42646.867656617665, 42975.785121074194, 43535.346969794846, 31868.84065579657, 32028.0, 32303.838480807444, 32391.676083238865, 32396.83801580977, 31192.688073119887, 31278.37443251168, 31480.842595786875, 32018.51972220372, 32026.35947280995, 35950.820245898605, 36086.0, 36185.45721814122, 36320.636793631726, 36496.63503364933, 29991.250218744706, 30146.397072058873, 30225.848870756385, 30235.0, 30674.846625766728, 22782.088716451155, 23280.53438931246, 23406.18078367249, 23868.283951481484, 23938.640920386555], "value": 16976.312788157597, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.3645517020938, 567.860874085849, 571.6512927114462, 591.7248479457052, 606.6481440764355, 22198.667019994693, 23081.653775193365, 23203.535929281403, 23212.0, 23299.534009319825, 23877.522449550997, 24298.878505607492, 24433.75566244337, 24612.0, 24916.50166996659, 6565.606063636185, 6720.495962802785, 6748.696308666097, 6770.661466926658, 6783.491238157133, 6598.241202261729, 6638.103855979453, 6695.062691223233, 6717.563358381714, 6744.887093629545, 6082.695865206722, 6311.053341998691, 6317.905231421532, 6349.047642853563, 6658.234303055138, 6443.097966284724, 6472.546921715481, 6487.902681459782, 6490.221173459192, 6491.8052458425855, 5970.582059255854, 5981.222441082675, 6034.879302413927, 6034.939650603482, 6036.0, 27907.581386279224, 28084.297892552644, 28142.15573532797, 28241.435171296664, 28343.433131337257, 2090.3310940499046, 2112.229036401702, 2113.661814109735, 2116.301620465258, 2124.468882779305, 18785.0, 19100.426987190407, 19382.612347753107, 19475.513112172168, 19515.80484195168, 2437.792787613055, 2468.827182097254, 2481.727010028895, 2495.0, 2507.949841003188, 128255.35872320579, 132169.33915330458, 132555.33722331424, 134797.0, 140168.29915850356, 14537.41850325975, 14692.898032647381, 14693.26533673312, 14721.263936803118, 14913.03065300752, 22030.559388812453, 22897.771022289897, 22923.42691432694, 22971.770282297297, 23043.88478057599, 9677.70966870995, 9725.9027409725, 9811.509424528746, 9924.40453572788, 10002.949690282561, 9161.816763664689, 9165.679201227926, 9189.632414703337, 9338.019507951703, 9350.625974961062, 8647.437916535531, 8710.519211734021, 8917.331200160013, 9019.954900225457, 9049.411788233743, 2723.167905378384, 2840.304125489227, 2855.271905664042, 2876.6116574262624, 2900.6374203224595, 960.8126415349079, 973.9415635061919, 986.5856340337076, 987.9851802222972, 998.2463240253562, 18697.626047478974, 19131.521711957314, 19220.519487012938, 19487.220511179396, 19705.901470492558, 998.7353351361895, 1012.0587853296357, 1015.304516406264, 1019.4647809899714, 1022.4887556221889, 10536.630238069156, 10651.627193048205, 10685.145188384911, 10722.463876806129, 10807.189460790314, 483985.0, 486644.0, 503095.0, 504645.0, 511661.0, 117294.41352793181, 117493.4125329385, 119619.0, 119770.4011479937, 120135.0, 1170.8302296167008, 1177.4760231696985, 1177.5172179406572, 1179.5930404010603, 1181.9763604727857, 16574.502764917073, 16654.0, 16909.577260568585, 17012.979221246766, 17214.13929303505, 46544.53455465402, 56915.43084569267, 57541.42458575361, 59077.40922590719, 59748.40251597602, 67166.66416667885, 67250.0, 67634.66182669056, 68251.0, 68280.0, 13977.231252281223, 14093.295335233403, 14158.787618185941, 14219.217943013233, 14363.138211707332, 21258.25596104129, 21709.0, 21875.234366797085, 22004.119835206413, 22049.448763781034, 17415.738763918805, 17499.82500174982, 17895.10524473797, 17959.371422000168, 18130.54673633117, 15492.922535387252, 15622.375104996128, 15774.13242271686, 16481.752773708642, 16494.0, 17004.88979237158, 18037.458876233733, 18110.81889181144, 18156.909215453838, 18405.63188736191, 13900.51348202808, 14057.437702491785, 14159.575212743634, 14170.07894486855, 14226.715465690835, 17628.1185940705, 17726.645467090842, 17735.46793596194, 17816.55458613545, 17888.0], "value": 11792.769131427438, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1285.588611644274, 1328.8272524571805, 1338.0232430325855, 1340.2628554295136, 1341.845687745909, 15189.924050379746, 15696.215189240535, 15710.685786284283, 15821.60445988848, 15830.050196988188, 15456.459023934165, 15725.84274157258, 15762.290696918637, 15770.684586308267, 15778.21108944554, 2702.9459410811774, 2736.53478908585, 2769.7922655800794, 2772.792040596953, 2772.9722702772915, 2625.1074634624224, 2725.305047212958, 2727.5772255300462, 2728.7816974641983, 2733.1253998720417, 2477.6531285620026, 2594.07910191882, 2603.8698065096764, 2605.8566778827253, 2728.9727102728916, 2715.321169707573, 2773.4175823077076, 2793.594928735322, 2797.5663772115354, 2809.1432113205565, 2718.8912443502236, 2731.931701707453, 2737.7262273772662, 2742.2321749910056, 2772.209920172761, 15006.249687515581, 15209.467668631656, 15391.769123463157, 15416.0, 15424.305906234134, 8176.0, 8346.165383461666, 8399.958000210021, 8478.06741258461, 8481.151884811532, 5351.759170837322, 5492.423295553949, 5585.664860108406, 5623.325200975909, 5658.66048037115, 1860.1164446887756, 1899.1928430417156, 1905.4950438133906, 1931.8357939575153, 1939.8157175068486, 27508.312292192655, 27539.586906196422, 27844.025459108834, 27871.303217419525, 28096.29759256035, 7045.68294426752, 7093.503454758221, 7140.178879428932, 7210.387117095106, 7281.817954551178, 17930.55173620644, 17945.371911983017, 17960.281588736565, 17964.55088622795, 17975.73036404455, 7656.234376562299, 7720.15078341382, 7761.107472640719, 7776.688932442639, 7788.84422311562, 7046.43628509718, 7138.107736532934, 7203.747868824566, 7517.699292028367, 7651.579163146081, 5101.591872650179, 5238.580913526908, 5285.207218917193, 5347.625666203328, 5358.0, 1382.198324971514, 1418.822647169104, 1532.6781375911185, 1580.2256894121797, 1584.2237303721095, 739.5525706947219, 871.1375738019316, 873.1835733588988, 875.3653601139123, 889.226373055446, 8683.52240626759, 8685.131486851264, 8705.347098967603, 8717.694880679273, 8762.605682744292, 922.7370199493247, 956.9138777510058, 957.4351132831663, 966.8211380894558, 971.4754032822339, 5408.810691625853, 5549.639273447213, 5553.389127196006, 5667.09326507765, 5798.739056742456, 22045.33863984083, 22668.319950401514, 22778.088876445086, 22835.771642283366, 23182.072717091465, 21145.0, 21780.237691680715, 22092.116315347528, 22333.10667573279, 22790.544189116456, 11357.148213883991, 11488.0, 11586.47860846247, 11592.47833847479, 11602.70993225176, 7844.882326764989, 7869.252421019994, 7883.881741773764, 7925.524468531907, 8031.0, 18331.725024124917, 19334.903325483283, 19447.70828437603, 19566.60866782628, 19796.307129250406, 18906.338278160198, 19198.712019319442, 19445.902770486056, 19507.21971121196, 19956.700649490558, 10942.17933654995, 11238.0, 11314.886851131383, 11315.603953861575, 11355.829662554903, 13874.583762487142, 14210.928945355206, 14262.358193881508, 14263.928680356532, 14313.212773297568, 10779.083777878654, 11027.558897644325, 11056.557737690402, 11154.330740155616, 11254.0, 11568.652940411801, 11682.182247242612, 11787.469563869476, 11808.822867657163, 12055.21641093326, 9844.3601165924, 9858.408495490006, 9861.950690246504, 9868.851967220355, 9898.604055837686, 7470.551766894004, 7505.362044226302, 7564.546127232384, 7571.924280757122, 7583.355414789805, 7356.117265927909, 7382.5570465772225, 7430.442716796154, 7435.070616172979, 7487.812804679927], "value": 6772.125608099789, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [509.236145781328, 511.4757373691965, 532.4515748778758, 532.9253904453379, 544.213611331626, 6144.907826382602, 6296.907010443214, 6304.779332723356, 6333.746650133995, 6343.0802533632595, 6010.402042437528, 6019.157317975487, 6035.939640603593, 6126.1009087183, 6156.322804491513, 5046.6719663221775, 5063.772130254148, 5083.262926875601, 5084.771185296652, 5090.211017292326, 4915.311856340115, 5007.674501157413, 5012.573931215851, 5057.190849464087, 5078.669886457387, 4960.941209398095, 5006.899862002758, 5016.986410871288, 5040.722760248185, 5048.545630893219, 5002.774875130628, 5022.6233032522705, 5043.218301163325, 5047.192449208109, 5068.5691716204165, 4474.7986340614425, 4504.504504504502, 4537.478190008125, 4547.15877562652, 4557.77211139445, 6124.152269194846, 6138.785142519991, 6185.87628247437, 6229.190205273331, 6239.50083993284, 5664.490195882349, 5747.166660834156, 5782.248307720011, 5783.652980821164, 5839.182514447981, 6431.163948686688, 6474.935250647527, 6510.1536800216145, 6520.380563846427, 6629.795610445777, 4808.903821923542, 4876.804927802884, 4895.2167653175675, 4918.532739389752, 4921.655484116113, 6798.66006699663, 6867.965660171767, 6876.656167191621, 6886.8622627547165, 6963.537657092017, 5040.546350828443, 5060.898782024339, 5099.898002039939, 5105.923411148836, 5112.258722485219, 5065.772040258197, 5090.643654944119, 5097.9745101275, 5104.770285337168, 5116.976604679079, 5632.718364081861, 5675.687837168913, 5699.971500142556, 5713.314402271754, 5766.769329226868, 6350.650714210763, 6591.736330546724, 6600.966995164993, 6665.566738162004, 6671.39957403836, 1674.9748753768704, 1702.9063401513035, 1728.1877517566722, 1732.8613710903098, 1732.9429048280538, 1213.9802565844732, 1239.3803098450774, 1241.3172754984903, 1254.084518301645, 1259.5906330442642, 5557.138643510262, 5594.678208543409, 5653.830385088454, 5687.118496633028, 5698.31620205578, 6502.382273683992, 6603.174603174603, 6647.368499992493, 6668.099806526154, 6714.3957043866285, 5602.775888964396, 5606.915896261559, 5632.915506267327, 5681.233033540502, 5717.857053573611, 3424.8972530824117, 3481.8259087045544, 3507.4917785352545, 3538.2039041216035, 3609.729270304738, 6420.871582568322, 6422.2614399344675, 6563.523207278419, 6567.408933196035, 6596.373344532261, 6895.413889819321, 6914.135733033371, 6919.34266244716, 6924.4460443165435, 6929.44564434844, 6390.392912673288, 6447.387498187664, 6496.123023391781, 6518.315576864551, 6551.21385433751, 6619.0, 6646.235682896336, 6679.966600166968, 6702.731890724316, 6761.661916904233, 6588.736450541925, 6659.500537459807, 6730.798076057726, 6742.393184613408, 6749.5612785168805, 6398.176519691866, 6453.385554567556, 6490.48076153916, 6520.739170433129, 6525.347465253437, 4893.241547560134, 4977.601791856715, 4997.575206107522, 5045.192769156917, 5056.7471626419265, 6594.472442204708, 6651.301613330724, 6680.565763225375, 6695.866082678222, 6782.762603308861, 6289.119523266655, 6397.4562162216735, 6415.1981002374705, 6489.675516224264, 6552.508561857784, 6236.906446403398, 6279.560430769985, 6436.388543088399, 6442.581232219891, 6486.837829054122, 6083.908741368971, 6237.7193026314835, 6317.652529110943, 6338.936610633835, 6351.872962540631, 6071.696415179312, 6462.903056454063, 6495.382938620824, 6497.628365646599, 6522.5760325578685, 6206.224221972254, 6266.185395898504, 6266.216722909637, 6333.714982825876, 6415.294317624965], "value": 5047.374020521851, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [899.5547204133954, 900.3112618846579, 923.4413180026085, 930.2557953637089, 936.7283487788542, 17622.73565896511, 18150.546236344097, 18377.724334134964, 18399.0, 18493.63012739746, 17222.311107555714, 17264.48206553802, 17506.824931750678, 17540.824591754077, 17788.377406790732, 947.7535840681403, 952.200151872427, 955.3169483819067, 962.0475729028246, 962.2302158273388, 980.5538479991623, 985.4432245781146, 986.6201512417734, 986.8075725233582, 991.6529214774807, 986.9161121304697, 1019.8266294729914, 1031.2523420520101, 1032.143321043532, 1046.0585473074257, 1009.8232809258424, 1014.4623349624711, 1015.3298822776932, 1020.143079812957, 1025.118398177563, 716.2300526933515, 730.1967835381091, 731.3198725185575, 747.308739416038, 748.9026426564566, 18342.174602142935, 18494.0, 18623.720644190347, 18687.71968420475, 18803.905980470146, 22013.76359992595, 22231.888840555694, 22827.88586057059, 22917.885410573006, 23305.417364565852, 15656.0, 16033.51899443007, 16162.676746465122, 16369.345226191057, 16385.83614163855, 3732.309522738302, 3787.8484860605545, 3807.9428808567895, 3817.1220619257724, 3825.1775868188197, 141123.0, 142250.28874855558, 143893.0, 147008.52991470054, 147935.0, 16849.41027064047, 16958.576035598962, 17256.309747610205, 17422.912885435493, 17461.563460913578, 31894.043178704676, 32365.0, 32517.51223731646, 32623.836880815445, 32752.672473275437, 8413.537255450887, 8560.400771946028, 8572.485650860968, 8584.74245772628, 8595.140485951355, 4141.254574176677, 4160.271952408377, 4203.642690371292, 4215.683823713233, 4270.274053410928, 5190.429052804188, 5272.420033796279, 5284.920726189111, 5287.127623942007, 5302.867428314323, 966.8308046092046, 978.8384916488842, 987.5407935310116, 996.6312464388222, 1000.46475135802, 674.318937872752, 680.9727610895509, 690.0718533572337, 694.9617771022541, 695.8677851208254, 11122.22144449897, 11155.553777848796, 11345.319280843176, 11397.715057123638, 11791.29252244868, 622.8941080016408, 632.8038308124496, 638.3201889987149, 643.4080645805869, 645.2676212498848, 5116.513931176532, 5179.326687530597, 5199.948000519947, 5261.289725887033, 5289.68261904287, 124926.37536812258, 125359.0, 125717.37141314235, 126056.0, 130162.34918825346, 108248.0, 109162.0, 111034.0, 113187.43406282915, 114309.0, 97975.0, 98253.15989386592, 99837.50081249548, 100016.99983000223, 101200.49399752954, 9626.32615716893, 9626.95186524063, 9885.950570247103, 9942.751431214278, 9962.701118966443, 43942.0, 44634.3304850434, 44834.0, 46067.76966115148, 46237.768811157075, 57196.71401642965, 57791.422085778606, 57895.0, 58248.4175158243, 59787.0, 15581.454649087227, 15753.212339382755, 15788.526344209693, 15849.366025358857, 15909.761353579937, 17350.39273625417, 17497.47507574775, 17508.037057961934, 17518.91240543789, 17723.02523361176, 14359.425622974964, 14383.137011779327, 14413.423463061361, 14413.78379324332, 14690.118592884033, 14128.43486260538, 14233.074850134708, 14279.64300892486, 14376.496822611158, 14558.854411456174, 11676.357800321064, 11773.705657358634, 11828.645140645795, 11836.585719499777, 11846.703832403915, 10640.467976601294, 10903.890961090288, 10995.890041099807, 11058.889411106107, 11117.44412779374, 11248.200287953889, 11299.774004519699, 11390.544378224778, 11426.600068997544, 11483.425828708698], "value": 8691.642679297087, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1462.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 114.0, 110.0, 110.0, 116.0, 116.0, 108.0, 112.0, 109.0, 111.0], "value": 111.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 122.0, 117.0, 126.0, 145.0, 117.0, 126.0, 137.0, 119.0, 118.0], "value": 124.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 165.0, 167.0, 162.0, 173.0, 168.0, 174.0, 162.0, 165.0, 163.0], "value": 166.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 83.0, 78.0, 83.0, 76.0, 74.0, 78.0, 78.0, 81.0, 91.0], "value": 80.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 83.0, 83.0, 84.0, 78.0, 90.0, 80.0, 80.0, 84.0, 88.0], "value": 82.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 125.0, 119.0, 114.0, 114.0, 114.0, 114.0, 126.0, 121.0, 116.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 150.0, 157.0, 151.0, 148.0, 148.0, 149.0, 160.0, 148.0, 149.0], "value": 151.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 99.0, 101.0, 95.0, 94.0, 97.0, 105.0, 95.0, 96.0, 94.0], "value": 97.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 58.0, 52.0, 52.0, 53.0, 54.0, 58.0, 53.0, 51.0, 63.0], "value": 54.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [39.0, 47.0, 49.0, 38.0, 48.0, 41.0, 38.0, 38.0, 49.0, 43.0], "value": 43.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 74.0, 77.0, 78.0, 72.0, 82.0, 79.0, 80.0, 76.0], "value": 77.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 119.0, 115.0, 115.0, 119.0, 113.0, 117.0, 116.0, 111.0, 117.0], "value": 116.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 171.0, 178.0, 174.0, 171.0, 181.0, 167.0, 169.0, 166.0, 168.0], "value": 171.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 77.0, 67.0, 65.0, 67.0, 68.0, 65.0, 65.0, 67.0, 64.0], "value": 67.3, "unit": "score"}]}]} 12:28:44 INFO - Return code: 0 12:28:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:28:44 INFO - # TBPL SUCCESS # 12:28:44 INFO - Running post-action listener: _package_coverage_data 12:28:44 INFO - Running post-action listener: _resource_record_post_action 12:28:44 INFO - [mozharness: 2017-09-26 19:28:44.399037Z] Finished run-tests step (success) 12:28:44 INFO - Running post-run listener: _resource_record_post_run 12:28:44 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 341270528; Read time: 12; Write time: 182280 12:28:44 INFO - TinderboxPrint: CPU usage
13.3% 12:28:44 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 12:28:44 INFO - TinderboxPrint: I/O write bytes / time
341,270,528 / 182,280 12:28:44 INFO - TinderboxPrint: CPU idle
8,258.4 (86.7%) 12:28:44 INFO - TinderboxPrint: CPU user
1,202.8 (12.6%) 12:28:44 INFO - TinderboxPrint: Swap in / out
0 / 0 12:28:44 INFO - install - Wall time: 19s; CPU: 13.0%; Read bytes: 0; Write bytes: 10223616; Read time: 0; Write time: 984 12:28:44 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 12:28:44 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 331046912; Read time: 0; Write time: 181296 12:28:45 INFO - Running post-run listener: _upload_blobber_files 12:28:45 INFO - Blob upload gear active. 12:28:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:28:45 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 12:28:45 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'] 12:28:45 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 12:28:45 INFO - (blobuploader) - INFO - Open directory for files ... 12:28:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 12:28:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:28:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:28:46 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 12:28:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:28:46 INFO - (blobuploader) - INFO - Done attempting. 12:28:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:28:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:28:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:28:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:28:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:28:47 INFO - (blobuploader) - INFO - Done attempting. 12:28:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:28:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:28:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:28:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:28:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:28:48 INFO - (blobuploader) - INFO - Done attempting. 12:28:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:28:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:28:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:28:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:28:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:28:56 INFO - (blobuploader) - INFO - Done attempting. 12:28:56 INFO - (blobuploader) - INFO - Iteration through files over. 12:28:56 INFO - Return code: 0 12:28:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:28:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:28:56 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d69c219daf58f5369e33201ca75124b2205d60ba239a5782948798a5c4b0b5088155831658b545464973bfa00cfb46af1c2e839ccc3acf8a64f20ef7ef68918c", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8d05884a33fc899b58c65e87dddfd739c20332e09dc13bbb29e379efb688316ca149c073cb9af983c3eeae23732c8bb6ce24e77ca0db03f2621d852366994935", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/afffde650e3be6c3864db8e231650212a38cc8a7aa4ce7edc783b949cde17d86973e949a94d4358e9eb274ed166d8c3512aa58230aaed2fbf94d3897532b872c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e473d6a1a656793d3ae328497b096462c4883623edd22d19c57cbccef1ffcf0977e1a3db61742add269bd7b8d3618dd447c33963d6577429d4fb1172e21f07fc"} 12:28:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:28:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:28:56 INFO - Contents: 12:28:56 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d69c219daf58f5369e33201ca75124b2205d60ba239a5782948798a5c4b0b5088155831658b545464973bfa00cfb46af1c2e839ccc3acf8a64f20ef7ef68918c", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8d05884a33fc899b58c65e87dddfd739c20332e09dc13bbb29e379efb688316ca149c073cb9af983c3eeae23732c8bb6ce24e77ca0db03f2621d852366994935", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/afffde650e3be6c3864db8e231650212a38cc8a7aa4ce7edc783b949cde17d86973e949a94d4358e9eb274ed166d8c3512aa58230aaed2fbf94d3897532b872c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e473d6a1a656793d3ae328497b096462c4883623edd22d19c57cbccef1ffcf0977e1a3db61742add269bd7b8d3618dd447c33963d6577429d4fb1172e21f07fc"} 12:28:56 INFO - Running post-run listener: copy_logs_to_upload_dir 12:28:56 INFO - Copying logs to upload dir... 12:28:56 INFO - mkdir: /builds/slave/test/build/upload/logs 12:28:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.292213 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2017-09-26 12:28:56.230202) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-26 12:28:56.234063) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1506452759.584495-1673151166 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/d69c219daf58f5369e33201ca75124b2205d60ba239a5782948798a5c4b0b5088155831658b545464973bfa00cfb46af1c2e839ccc3acf8a64f20ef7ef68918c", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8d05884a33fc899b58c65e87dddfd739c20332e09dc13bbb29e379efb688316ca149c073cb9af983c3eeae23732c8bb6ce24e77ca0db03f2621d852366994935", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/afffde650e3be6c3864db8e231650212a38cc8a7aa4ce7edc783b949cde17d86973e949a94d4358e9eb274ed166d8c3512aa58230aaed2fbf94d3897532b872c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e473d6a1a656793d3ae328497b096462c4883623edd22d19c57cbccef1ffcf0977e1a3db61742add269bd7b8d3618dd447c33963d6577429d4fb1172e21f07fc"} build_url:https://queue.taskcluster.net/v1/task/CfEmsjFlSySZu2syzfRtJA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011264 build_url: 'https://queue.taskcluster.net/v1/task/CfEmsjFlSySZu2syzfRtJA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d69c219daf58f5369e33201ca75124b2205d60ba239a5782948798a5c4b0b5088155831658b545464973bfa00cfb46af1c2e839ccc3acf8a64f20ef7ef68918c", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8d05884a33fc899b58c65e87dddfd739c20332e09dc13bbb29e379efb688316ca149c073cb9af983c3eeae23732c8bb6ce24e77ca0db03f2621d852366994935", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/afffde650e3be6c3864db8e231650212a38cc8a7aa4ce7edc783b949cde17d86973e949a94d4358e9eb274ed166d8c3512aa58230aaed2fbf94d3897532b872c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e473d6a1a656793d3ae328497b096462c4883623edd22d19c57cbccef1ffcf0977e1a3db61742add269bd7b8d3618dd447c33963d6577429d4fb1172e21f07fc"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-26 12:28:56.262547) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 12:28:56.262883) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1506452759.584495-1673151166 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004520 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 12:28:56.346391) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-26 12:28:56.346764) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-26 12:28:56.347077) ========= ========= Total master_lag: 0.20 =========