builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s-pgo slave: talos-linux64-ix-023 starttime: 1505862339.96 results: success (0) revision: a0eb21bf55e1c1ae0ba311e6f2273da05c712799 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-19 16:05:39.956192) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-19 16:05:39.956715) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-19 16:05:39.957105) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-19 16:05:40.067787) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 16:05:40.068045) ========= 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=6d15e502d8e29d5d2676d664000001c3-1505860996.552136-1997593267 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-19 16:05:40-- 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% 101M=0s 2017-09-19 16:05:40 (101 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.163825 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 16:05:40.281582) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 16:05:40.281876) ========= 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=6d15e502d8e29d5d2676d664000001c3-1505860996.552136-1997593267 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015831 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 16:05:40.369859) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 16:05:40.370156) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a0eb21bf55e1c1ae0ba311e6f2273da05c712799 --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 a0eb21bf55e1c1ae0ba311e6f2273da05c712799 --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=6d15e502d8e29d5d2676d664000001c3-1505860996.552136-1997593267 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-19 16:05:40,434 truncating revision to first 12 chars 2017-09-19 16:05:40,434 Setting DEBUG logging. 2017-09-19 16:05:40,434 attempt 1/10 2017-09-19 16:05:40,434 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a0eb21bf55e1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-19 16:05:40,801 unpacking tar archive at: mozilla-central-a0eb21bf55e1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.659613 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 16:05:41.074566) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-19 16:05:41.074844) ========= script_repo_revision: a0eb21bf55e1c1ae0ba311e6f2273da05c712799 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-19 16:05:41.075212) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-19 16:05:41.075778) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-19 16:05:41.088914) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2017-09-19 16:05:41.089205) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-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-stylo-disabled-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=6d15e502d8e29d5d2676d664000001c3-1505860996.552136-1997593267 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:05:41 INFO - MultiFileLogger online at 20170919 16:05:41 in /builds/slave/test 16:05:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 16:05:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:05:41 INFO - {'append_to_log': False, 16:05:41 INFO - 'base_work_dir': '/builds/slave/test', 16:05:41 INFO - 'blob_upload_branch': 'Firefox', 16:05:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:05:41 INFO - 'branch': 'Firefox', 16:05:41 INFO - 'buildbot_json_path': 'buildprops.json', 16:05:41 INFO - 'code_coverage': False, 16:05:41 INFO - 'config_files': ('talos/linux_config.py',), 16:05:41 INFO - 'default_actions': ('clobber', 16:05:41 INFO - 'read-buildbot-config', 16:05:41 INFO - 'download-and-extract', 16:05:41 INFO - 'populate-webroot', 16:05:41 INFO - 'create-virtualenv', 16:05:41 INFO - 'install', 16:05:41 INFO - 'setup-mitmproxy', 16:05:41 INFO - 'run-tests'), 16:05:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:05:41 INFO - 'disable_ccov_upload': False, 16:05:41 INFO - 'disable_stylo': False, 16:05:41 INFO - 'download_minidump_stackwalk': True, 16:05:41 INFO - 'download_symbols': 'ondemand', 16:05:41 INFO - 'enable_stylo': False, 16:05:41 INFO - 'enable_webrender': False, 16:05:41 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 16:05:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:05:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:05:41 INFO - 'gecko_profile': False, 16:05:41 INFO - 'gecko_profile_interval': 0, 16:05:41 INFO - 'installer_path': 'installer.exe', 16:05:41 INFO - 'log_level': 'info', 16:05:41 INFO - 'log_name': 'talos', 16:05:41 INFO - 'log_to_console': True, 16:05:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:05:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:05:41 INFO - 'opt_config_files': (), 16:05:41 INFO - 'pip_index': False, 16:05:41 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 16:05:41 INFO - 'system_bits': '32', 16:05:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:05:41 INFO - 'title': 'talos-linux64-ix-023', 16:05:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:05:41 INFO - 'use_talos_json': True, 16:05:41 INFO - 'verify': 'False', 16:05:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:05:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:05:41 INFO - 'work_dir': 'build'} 16:05:41 INFO - [mozharness: 2017-09-19 23:05:41.338366Z] Running clobber step. 16:05:41 INFO - Running pre-action listener: _resource_record_pre_action 16:05:41 INFO - Running main action method: clobber 16:05:41 INFO - rmtree: /builds/slave/test/build 16:05:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:05:42 INFO - Running post-action listener: _resource_record_post_action 16:05:42 INFO - [mozharness: 2017-09-19 23:05:42.283594Z] Finished clobber step (success) 16:05:42 INFO - [mozharness: 2017-09-19 23:05:42.283690Z] Running read-buildbot-config step. 16:05:42 INFO - Running pre-action listener: _resource_record_pre_action 16:05:42 INFO - Running main action method: read_buildbot_config 16:05:42 INFO - Using buildbot properties: 16:05:42 INFO - { 16:05:42 INFO - "project": "", 16:05:42 INFO - "product": "firefox", 16:05:42 INFO - "who": "kwierso@gmail.com", 16:05:42 INFO - "installer_path": "public/build/target.tar.bz2", 16:05:42 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 16:05:42 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 16:05:42 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-stylo-disabled-e10s", 16:05:42 INFO - "stage_platform": "linux64-pgo", 16:05:42 INFO - "basedir": "/builds/slave/test", 16:05:42 INFO - "buildnumber": 35, 16:05:42 INFO - "platform": "ubuntu64_hw", 16:05:42 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:05:42 INFO - "slavebuilddir": "test", 16:05:42 INFO - "taskId": "SB959L96RFGIXJ72GmP23Q", 16:05:42 INFO - "branch": "mozilla-central", 16:05:42 INFO - "script_repo_revision": "production", 16:05:42 INFO - "revision": "a0eb21bf55e1c1ae0ba311e6f2273da05c712799", 16:05:42 INFO - "slavename": "talos-linux64-ix-023", 16:05:42 INFO - "repo_path": "mozilla-central" 16:05:42 INFO - } 16:05:42 INFO - Finding installer, test and symbols from parent task. 16:05:42 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SB959L96RFGIXJ72GmP23Q'}, attempt #1 16:05:42 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SB959L96RFGIXJ72GmP23Q'}, attempt #1 16:05:43 INFO - Task dependencies: Y7gb7BDOTseBUm1jZrOsyg 16:05:43 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Y7gb7BDOTseBUm1jZrOsyg'}, attempt #1 16:05:43 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Y7gb7BDOTseBUm1jZrOsyg/artifacts/public/build/target.tar.bz2 16:05:43 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/Y7gb7BDOTseBUm1jZrOsyg/artifacts/public/build/target.test_packages.json 16:05:43 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Y7gb7BDOTseBUm1jZrOsyg/artifacts/public/build/target.crashreporter-symbols.zip 16:05:43 INFO - Running post-action listener: _resource_record_post_action 16:05:43 INFO - [mozharness: 2017-09-19 23:05:43.702679Z] Finished read-buildbot-config step (success) 16:05:43 INFO - [mozharness: 2017-09-19 23:05:43.702895Z] Running download-and-extract step. 16:05:43 INFO - Running pre-action listener: _resource_record_pre_action 16:05:43 INFO - Running main action method: download_and_extract 16:05:43 INFO - mkdir: /builds/slave/test/build/tests 16:05:43 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')]} 16:05:43 INFO - trying https://queue.taskcluster.net/v1/task/Y7gb7BDOTseBUm1jZrOsyg/artifacts/public/build/target.test_packages.json 16:05:43 INFO - Downloading https://queue.taskcluster.net/v1/task/Y7gb7BDOTseBUm1jZrOsyg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:05:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Y7gb7BDOTseBUm1jZrOsyg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:05:44 INFO - Downloaded 989 bytes. 16:05:44 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:05:44 INFO - Using the following test package requirements: 16:05:44 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 16:05:44 INFO - u'common': [u'target.common.tests.zip'], 16:05:44 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:05:44 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:05:44 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:05:44 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:05:44 INFO - u'mozbase': [u'target.common.tests.zip'], 16:05:44 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:05:44 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:05:44 INFO - u'web-platform': [u'target.common.tests.zip', 16:05:44 INFO - u'target.web-platform.tests.tar.gz'], 16:05:44 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:05:44 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 16:05:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Y7gb7BDOTseBUm1jZrOsyg/artifacts/public/build/target.common.tests.zip 16:05:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Y7gb7BDOTseBUm1jZrOsyg/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:05:44 INFO - Fetch https://queue.taskcluster.net/v1/task/Y7gb7BDOTseBUm1jZrOsyg/artifacts/public/build/target.common.tests.zip into memory 16:05:45 INFO - Content-Length response header: 55285033 16:05:45 INFO - Bytes received: 55285033 16:05:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Y7gb7BDOTseBUm1jZrOsyg/artifacts/public/build/target.talos.tests.zip 16:05:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Y7gb7BDOTseBUm1jZrOsyg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:05:56 INFO - Fetch https://queue.taskcluster.net/v1/task/Y7gb7BDOTseBUm1jZrOsyg/artifacts/public/build/target.talos.tests.zip into memory 16:05:57 INFO - Content-Length response header: 14508904 16:05:57 INFO - Bytes received: 14508904 16:05:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:05:57 INFO - trying https://queue.taskcluster.net/v1/task/Y7gb7BDOTseBUm1jZrOsyg/artifacts/public/build/target.tar.bz2 16:05:57 INFO - Downloading https://queue.taskcluster.net/v1/task/Y7gb7BDOTseBUm1jZrOsyg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:05:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Y7gb7BDOTseBUm1jZrOsyg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:05:59 INFO - Downloaded 62273763 bytes. 16:05:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Y7gb7BDOTseBUm1jZrOsyg/artifacts/public/build/target.tar.bz2 16:05:59 INFO - mkdir: /builds/slave/test/properties 16:05:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:05:59 INFO - Writing to file /builds/slave/test/properties/build_url 16:05:59 INFO - Contents: 16:05:59 INFO - build_url:https://queue.taskcluster.net/v1/task/Y7gb7BDOTseBUm1jZrOsyg/artifacts/public/build/target.tar.bz2 16:05:59 INFO - Running post-action listener: _resource_record_post_action 16:05:59 INFO - Running post-action listener: find_tests_for_verification 16:05:59 INFO - Running post-action listener: set_extra_try_arguments 16:05:59 INFO - [mozharness: 2017-09-19 23:05:59.105258Z] Finished download-and-extract step (success) 16:05:59 INFO - [mozharness: 2017-09-19 23:05:59.105356Z] Running populate-webroot step. 16:05:59 INFO - Running pre-action listener: _resource_record_pre_action 16:05:59 INFO - Running main action method: populate_webroot 16:05:59 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:05:59 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:05:59 INFO - 'tests': ['tresize', 16:05:59 INFO - 'tcanvasmark']}, 16:05:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:05:59 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:05:59 INFO - 'tests': ['dromaeo_css', 16:05:59 INFO - 'kraken']}, 16:05:59 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:05:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:05:59 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:05:59 INFO - 'talos_options': ['--disable-stylo'], 16:05:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:05:59 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:05:59 INFO - 'tests': ['damp', 'tps']}, 16:05:59 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:05:59 INFO - 'talos_options': ['--disable-stylo'], 16:05:59 INFO - 'tests': ['damp', 'tps']}, 16:05:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:05:59 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:05:59 INFO - 'tests': ['dromaeo_dom']}, 16:05:59 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 16:05:59 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:05:59 INFO - 'tests': ['basic_compositor_video', 16:05:59 INFO - 'glvideo']}, 16:05:59 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 16:05:59 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 16:05:59 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:05:59 INFO - 'talos_options': ['--disable-stylo'], 16:05:59 INFO - 'tests': ['ts_paint_webext', 16:05:59 INFO - 'tp5o_webext']}, 16:05:59 INFO - 'other-e10s': {'tests': ['a11yr', 16:05:59 INFO - 'ts_paint', 16:05:59 INFO - 'tpaint', 16:05:59 INFO - 'sessionrestore', 16:05:59 INFO - 'sessionrestore_many_windows', 16:05:59 INFO - 'sessionrestore_no_auto_restore', 16:05:59 INFO - 'tabpaint']}, 16:05:59 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:05:59 INFO - 'tests': ['a11yr', 16:05:59 INFO - 'ts_paint', 16:05:59 INFO - 'tpaint', 16:05:59 INFO - 'sessionrestore', 16:05:59 INFO - 'sessionrestore_many_windows', 16:05:59 INFO - 'sessionrestore_no_auto_restore', 16:05:59 INFO - 'tabpaint']}, 16:05:59 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 16:05:59 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 16:05:59 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:05:59 INFO - 'tests': ['perf_reftest_singletons']}, 16:05:59 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:05:59 INFO - 'tests': ['bloom_basic']}, 16:05:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:05:59 INFO - 'tsvgr_opacity', 16:05:59 INFO - 'tart', 16:05:59 INFO - 'tscrollx', 16:05:59 INFO - 'tsvg_static']}, 16:05:59 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:05:59 INFO - 'tests': ['tsvgx', 16:05:59 INFO - 'tsvgr_opacity', 16:05:59 INFO - 'tart', 16:05:59 INFO - 'tscrollx', 16:05:59 INFO - 'tsvg_static']}, 16:05:59 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:05:59 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:05:59 INFO - 'talos_options': ['--disable-stylo'], 16:05:59 INFO - 'tests': ['tp5o']}, 16:05:59 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:05:59 INFO - 'talos_options': ['--mitmproxy', 16:05:59 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:05:59 INFO - '--firstNonBlankPaint'], 16:05:59 INFO - 'tests': ['tp6_google', 16:05:59 INFO - 'tp6_youtube', 16:05:59 INFO - 'tp6_amazon', 16:05:59 INFO - 'tp6_facebook']}, 16:05:59 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:05:59 INFO - 'talos_options': ['--disable-stylo', 16:05:59 INFO - '--mitmproxy', 16:05:59 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:05:59 INFO - '--firstNonBlankPaint'], 16:05:59 INFO - 'tests': ['tp6_google', 16:05:59 INFO - 'tp6_youtube', 16:05:59 INFO - 'tp6_amazon', 16:05:59 INFO - 'tp6_facebook']}, 16:05:59 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:05:59 INFO - 'talos_options': ['--stylo-threads=1', 16:05:59 INFO - '--mitmproxy', 16:05:59 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:05:59 INFO - '--firstNonBlankPaint'], 16:05:59 INFO - 'tests': ['tp6_google', 16:05:59 INFO - 'tp6_youtube', 16:05:59 INFO - 'tp6_amazon', 16:05:59 INFO - 'tp6_facebook']}, 16:05:59 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:05:59 INFO - 'talos_options': ['--xperf_path', 16:05:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:05:59 INFO - 'tests': ['tp5n']}, 16:05:59 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:05:59 INFO - 'talos_options': ['--disable-stylo', 16:05:59 INFO - '--xperf_path', 16:05:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:05:59 INFO - 'tests': ['tp5n']}}} 16:05:59 INFO - Running post-action listener: _resource_record_post_action 16:05:59 INFO - [mozharness: 2017-09-19 23:05:59.120278Z] Finished populate-webroot step (success) 16:05:59 INFO - [mozharness: 2017-09-19 23:05:59.120367Z] Running create-virtualenv step. 16:05:59 INFO - Running pre-action listener: _resource_record_pre_action 16:05:59 INFO - Running main action method: create_virtualenv 16:05:59 INFO - Creating virtualenv /builds/slave/test/build/venv 16:05:59 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:05:59 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 16:05:59 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 16:05:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:05:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:05:59 INFO - Installing distribute.............................................................................................................................................................................................done. 16:06:00 INFO - Installing pip...............done. 16:06:00 INFO - Return code: 0 16:06:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:06:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:06:00 INFO - Reading from file tmpfile_stdout 16:06:00 INFO - Output received: 16:06:00 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 16:06:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:06:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:06:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:06:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:06:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:06:00 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 0x234c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2515a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b8a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26bc090>, '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 0x26bcd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b6f90>, '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': '6d15e502d8e29d5d2676d664000001c3-1505860996.552136-1997593267', '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 16:06:00 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 16:06:00 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 16:06:00 INFO - Using env: {'DISPLAY': ':0', 16:06:00 INFO - 'HOME': '/home/cltbld', 16:06:00 INFO - 'LANG': 'en_US.UTF-8', 16:06:00 INFO - 'LANGUAGE': 'en_US:en', 16:06:00 INFO - 'LOGNAME': 'cltbld', 16:06:00 INFO - 'MAIL': '/var/mail/cltbld', 16:06:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:06:00 INFO - 'MOZ_NO_REMOTE': '1', 16:06:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:06:00 INFO - 'NO_EM_RESTART': '1', 16:06:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:06:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:06:00 INFO - 'PWD': '/builds/slave/test', 16:06:00 INFO - 'SHELL': '/bin/bash', 16:06:00 INFO - 'SHLVL': '1', 16:06:00 INFO - 'TERM': 'linux', 16:06:00 INFO - 'TMOUT': '86400', 16:06:00 INFO - 'USER': 'cltbld', 16:06:00 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1505860996.552136-1997593267', 16:06:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:06:00 INFO - '_': '/tools/buildbot/bin/python'} 16:06:03 INFO - Ignoring indexes: http://pypi.python.org/simple/ 16:06:03 INFO - Downloading/unpacking pip>=1.5 16:06:03 INFO - Running setup.py egg_info for package pip 16:06:03 INFO - warning: no files found matching 'pip/cacert.pem' 16:06:03 INFO - warning: no files found matching '*.html' under directory 'docs' 16:06:03 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 16:06:03 INFO - no previously-included directories found matching 'docs/_build/_sources' 16:06:03 INFO - Installing collected packages: pip 16:06:03 INFO - Found existing installation: pip 1.1 16:06:03 INFO - Uninstalling pip: 16:06:03 INFO - Successfully uninstalled pip 16:06:03 INFO - Running setup.py install for pip 16:06:03 INFO - warning: no files found matching 'pip/cacert.pem' 16:06:03 INFO - warning: no files found matching '*.html' under directory 'docs' 16:06:03 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 16:06:03 INFO - no previously-included directories found matching 'docs/_build/_sources' 16:06:03 INFO - Installing pip script to /builds/slave/test/build/venv/bin 16:06:03 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 16:06:03 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 16:06:03 INFO - Successfully installed pip 16:06:03 INFO - Cleaning up... 16:06:03 INFO - Return code: 0 16:06:03 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:06:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:06:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:06:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:06:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:06:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x234c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2515a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b8a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26bc090>, '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 0x26bcd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b6f90>, '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': '6d15e502d8e29d5d2676d664000001c3-1505860996.552136-1997593267', '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 16:06:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 16:06:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 16:06:03 INFO - Using env: {'DISPLAY': ':0', 16:06:03 INFO - 'HOME': '/home/cltbld', 16:06:03 INFO - 'LANG': 'en_US.UTF-8', 16:06:03 INFO - 'LANGUAGE': 'en_US:en', 16:06:03 INFO - 'LOGNAME': 'cltbld', 16:06:03 INFO - 'MAIL': '/var/mail/cltbld', 16:06:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:06:03 INFO - 'MOZ_NO_REMOTE': '1', 16:06:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:06:03 INFO - 'NO_EM_RESTART': '1', 16:06:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:06:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:06:03 INFO - 'PWD': '/builds/slave/test', 16:06:03 INFO - 'SHELL': '/bin/bash', 16:06:03 INFO - 'SHLVL': '1', 16:06:03 INFO - 'TERM': 'linux', 16:06:03 INFO - 'TMOUT': '86400', 16:06:03 INFO - 'USER': 'cltbld', 16:06:03 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1505860996.552136-1997593267', 16:06:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:06:03 INFO - '_': '/tools/buildbot/bin/python'} 16:06:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:06:03 INFO - Downloading/unpacking psutil>=3.1.1 16:06:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:06:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:06:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:06:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:06:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:06:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:06:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:06:05 INFO - Installing collected packages: psutil 16:06:05 INFO - Running setup.py install for psutil 16:06:05 INFO - building 'psutil._psutil_linux' extension 16:06:05 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 16:06:06 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 16:06:06 INFO - building 'psutil._psutil_posix' extension 16:06:06 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 16:06:07 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 16:06:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:06:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:06:07 INFO - Successfully installed psutil 16:06:07 INFO - Cleaning up... 16:06:07 INFO - Return code: 0 16:06:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:06: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')]} 16:06:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:06: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')]} 16:06:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:06:07 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 0x234c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2515a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b8a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26bc090>, '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 0x26bcd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b6f90>, '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': '6d15e502d8e29d5d2676d664000001c3-1505860996.552136-1997593267', '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 16:06:07 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 16:06:07 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 16:06:07 INFO - Using env: {'DISPLAY': ':0', 16:06:07 INFO - 'HOME': '/home/cltbld', 16:06:07 INFO - 'LANG': 'en_US.UTF-8', 16:06:07 INFO - 'LANGUAGE': 'en_US:en', 16:06:07 INFO - 'LOGNAME': 'cltbld', 16:06:07 INFO - 'MAIL': '/var/mail/cltbld', 16:06:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:06:07 INFO - 'MOZ_NO_REMOTE': '1', 16:06:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:06:07 INFO - 'NO_EM_RESTART': '1', 16:06:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:06:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:06:07 INFO - 'PWD': '/builds/slave/test', 16:06:07 INFO - 'SHELL': '/bin/bash', 16:06:07 INFO - 'SHLVL': '1', 16:06:07 INFO - 'TERM': 'linux', 16:06:07 INFO - 'TMOUT': '86400', 16:06:07 INFO - 'USER': 'cltbld', 16:06:07 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1505860996.552136-1997593267', 16:06:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:06:07 INFO - '_': '/tools/buildbot/bin/python'} 16:06:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:06:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:06:07 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 16:06:07 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 16:06:07 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 16:06:07 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 16:06:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:06:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:06:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:06:08 INFO - Installing collected packages: mozsystemmonitor 16:06:08 INFO - Running setup.py install for mozsystemmonitor 16:06:08 INFO - Successfully installed mozsystemmonitor 16:06:08 INFO - Cleaning up... 16:06:08 INFO - Return code: 0 16:06:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:06:08 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')]} 16:06:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:06:08 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')]} 16:06:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:06:08 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 0x234c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2515a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b8a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26bc090>, '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 0x26bcd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b6f90>, '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': '6d15e502d8e29d5d2676d664000001c3-1505860996.552136-1997593267', '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 16:06:08 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 16:06:08 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 16:06:08 INFO - Using env: {'DISPLAY': ':0', 16:06:08 INFO - 'HOME': '/home/cltbld', 16:06:08 INFO - 'LANG': 'en_US.UTF-8', 16:06:08 INFO - 'LANGUAGE': 'en_US:en', 16:06:08 INFO - 'LOGNAME': 'cltbld', 16:06:08 INFO - 'MAIL': '/var/mail/cltbld', 16:06:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:06:08 INFO - 'MOZ_NO_REMOTE': '1', 16:06:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:06:08 INFO - 'NO_EM_RESTART': '1', 16:06:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:06:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:06:08 INFO - 'PWD': '/builds/slave/test', 16:06:08 INFO - 'SHELL': '/bin/bash', 16:06:08 INFO - 'SHLVL': '1', 16:06:08 INFO - 'TERM': 'linux', 16:06:08 INFO - 'TMOUT': '86400', 16:06:08 INFO - 'USER': 'cltbld', 16:06:08 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1505860996.552136-1997593267', 16:06:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:06:08 INFO - '_': '/tools/buildbot/bin/python'} 16:06:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:06:08 INFO - Downloading/unpacking jsonschema==2.5.1 16:06:08 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 16:06:08 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 16:06:08 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 16:06:08 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 16:06:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:06:10 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:06:10 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 16:06:10 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 16:06:10 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 16:06:10 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 16:06:10 INFO - Downloading functools32-3.2.3-2.tar.gz 16:06:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:06:10 INFO - warning: no files found matching '*.txt' 16:06:10 INFO - no previously-included directories found matching 'build' 16:06:10 INFO - no previously-included directories found matching 'dist' 16:06:10 INFO - no previously-included directories found matching '.git*' 16:06:10 INFO - Installing collected packages: jsonschema, functools32 16:06:10 INFO - Running setup.py install for functools32 16:06:10 INFO - warning: no files found matching '*.txt' 16:06:10 INFO - no previously-included directories found matching 'build' 16:06:10 INFO - no previously-included directories found matching 'dist' 16:06:10 INFO - no previously-included directories found matching '.git*' 16:06:10 INFO - Successfully installed jsonschema functools32 16:06:10 INFO - Cleaning up... 16:06:10 INFO - Return code: 0 16:06:10 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:06:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:06:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:06:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:06:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:06:10 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 0x234c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2515a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b8a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26bc090>, '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 0x26bcd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b6f90>, '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': '6d15e502d8e29d5d2676d664000001c3-1505860996.552136-1997593267', '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 16:06:10 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 16:06:10 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 16:06:10 INFO - Using env: {'DISPLAY': ':0', 16:06:10 INFO - 'HOME': '/home/cltbld', 16:06:10 INFO - 'LANG': 'en_US.UTF-8', 16:06:10 INFO - 'LANGUAGE': 'en_US:en', 16:06:10 INFO - 'LOGNAME': 'cltbld', 16:06:10 INFO - 'MAIL': '/var/mail/cltbld', 16:06:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:06:10 INFO - 'MOZ_NO_REMOTE': '1', 16:06:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:06:10 INFO - 'NO_EM_RESTART': '1', 16:06:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:06:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:06:10 INFO - 'PWD': '/builds/slave/test', 16:06:10 INFO - 'SHELL': '/bin/bash', 16:06:10 INFO - 'SHLVL': '1', 16:06:10 INFO - 'TERM': 'linux', 16:06:10 INFO - 'TMOUT': '86400', 16:06:10 INFO - 'USER': 'cltbld', 16:06:10 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1505860996.552136-1997593267', 16:06:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:06:10 INFO - '_': '/tools/buildbot/bin/python'} 16:06:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:06:10 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:06:10 INFO - Cleaning up... 16:06:10 INFO - Return code: 0 16:06:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:06:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:06:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:06:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:06:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:06:10 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 0x234c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2515a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b8a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26bc090>, '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 0x26bcd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b6f90>, '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': '6d15e502d8e29d5d2676d664000001c3-1505860996.552136-1997593267', '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 16:06:10 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 16:06:10 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 16:06:10 INFO - Using env: {'DISPLAY': ':0', 16:06:10 INFO - 'HOME': '/home/cltbld', 16:06:10 INFO - 'LANG': 'en_US.UTF-8', 16:06:10 INFO - 'LANGUAGE': 'en_US:en', 16:06:10 INFO - 'LOGNAME': 'cltbld', 16:06:10 INFO - 'MAIL': '/var/mail/cltbld', 16:06:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:06:10 INFO - 'MOZ_NO_REMOTE': '1', 16:06:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:06:10 INFO - 'NO_EM_RESTART': '1', 16:06:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:06:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:06:10 INFO - 'PWD': '/builds/slave/test', 16:06:10 INFO - 'SHELL': '/bin/bash', 16:06:10 INFO - 'SHLVL': '1', 16:06:10 INFO - 'TERM': 'linux', 16:06:10 INFO - 'TMOUT': '86400', 16:06:10 INFO - 'USER': 'cltbld', 16:06:10 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1505860996.552136-1997593267', 16:06:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:06:10 INFO - '_': '/tools/buildbot/bin/python'} 16:06:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:06:10 INFO - Downloading/unpacking blobuploader==1.2.4 16:06:10 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 16:06:10 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 16:06:10 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 16:06:10 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 16:06:11 INFO - Downloading blobuploader-1.2.4.tar.gz 16:06:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:06:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:06:12 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 16:06:12 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 16:06:12 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 16:06:12 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 16:06:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:06:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:06:12 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 16:06:12 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 16:06:12 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 16:06:12 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 16:06:12 INFO - Downloading docopt-0.6.1.tar.gz 16:06:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:06:12 INFO - Installing collected packages: blobuploader, requests, docopt 16:06:12 INFO - Running setup.py install for blobuploader 16:06:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:06:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:06:12 INFO - Running setup.py install for requests 16:06:13 INFO - Running setup.py install for docopt 16:06:13 INFO - Successfully installed blobuploader requests docopt 16:06:13 INFO - Cleaning up... 16:06:13 INFO - Return code: 0 16:06:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:06: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')]} 16:06:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:06: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')]} 16:06:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:06:13 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 0x234c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2515a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b8a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26bc090>, '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 0x26bcd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b6f90>, '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': '6d15e502d8e29d5d2676d664000001c3-1505860996.552136-1997593267', '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 16:06:13 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 16:06:13 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 16:06:13 INFO - Using env: {'DISPLAY': ':0', 16:06:13 INFO - 'HOME': '/home/cltbld', 16:06:13 INFO - 'LANG': 'en_US.UTF-8', 16:06:13 INFO - 'LANGUAGE': 'en_US:en', 16:06:13 INFO - 'LOGNAME': 'cltbld', 16:06:13 INFO - 'MAIL': '/var/mail/cltbld', 16:06:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:06:13 INFO - 'MOZ_NO_REMOTE': '1', 16:06:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:06:13 INFO - 'NO_EM_RESTART': '1', 16:06:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:06:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:06:13 INFO - 'PWD': '/builds/slave/test', 16:06:13 INFO - 'SHELL': '/bin/bash', 16:06:13 INFO - 'SHLVL': '1', 16:06:13 INFO - 'TERM': 'linux', 16:06:13 INFO - 'TMOUT': '86400', 16:06:13 INFO - 'USER': 'cltbld', 16:06:13 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1505860996.552136-1997593267', 16:06:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:06:13 INFO - '_': '/tools/buildbot/bin/python'} 16:06:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:06:13 INFO - Running setup.py (path:/tmp/pip-W6jcjs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:06:13 INFO - Running setup.py (path:/tmp/pip-hqismM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:06:13 INFO - Running setup.py (path:/tmp/pip-Cxk_qg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:06:13 INFO - Running setup.py (path:/tmp/pip-HERWzj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:06:13 INFO - Running setup.py (path:/tmp/pip-Jx81iM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:06:13 INFO - Running setup.py (path:/tmp/pip-yYus6k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:06:13 INFO - Running setup.py (path:/tmp/pip-xNkD3A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:06:13 INFO - Running setup.py (path:/tmp/pip-7tV4sm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:06:13 INFO - Running setup.py (path:/tmp/pip-zH2vik-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:06:14 INFO - Running setup.py (path:/tmp/pip-kpgLbl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:06:14 INFO - Running setup.py (path:/tmp/pip-382hh8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:06:14 INFO - Running setup.py (path:/tmp/pip-8H5gKG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:06:14 INFO - Running setup.py (path:/tmp/pip-hdJIsq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:06:14 INFO - Running setup.py (path:/tmp/pip-nUpgWB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:06:14 INFO - Running setup.py (path:/tmp/pip-Z5sZoS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:06:14 INFO - Running setup.py (path:/tmp/pip-viSyOz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:06:14 INFO - Running setup.py (path:/tmp/pip-vZJAJ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:06:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:06:14 INFO - Running setup.py install for manifestparser 16:06:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:06:14 INFO - Running setup.py install for mozcrash 16:06:14 INFO - Running setup.py install for mozdebug 16:06:14 INFO - Running setup.py install for mozdevice 16:06:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:06:14 INFO - Running setup.py install for mozfile 16:06:15 INFO - Running setup.py install for mozhttpd 16:06:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:06:15 INFO - Running setup.py install for mozinfo 16:06:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:06:15 INFO - Running setup.py install for mozInstall 16:06:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:06:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:06:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:06:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:06:15 INFO - Running setup.py install for mozleak 16:06:15 INFO - Running setup.py install for mozlog 16:06:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:06:15 INFO - Running setup.py install for moznetwork 16:06:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:06:15 INFO - Running setup.py install for mozprocess 16:06:15 INFO - Running setup.py install for mozprofile 16:06:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:06:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:06:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:06:15 INFO - Running setup.py install for mozrunner 16:06:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:06:16 INFO - Running setup.py install for mozscreenshot 16:06:16 INFO - Running setup.py install for moztest 16:06:16 INFO - Running setup.py install for mozversion 16:06:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:06:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:06:16 INFO - Cleaning up... 16:06:16 INFO - Return code: 0 16:06:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:06:16 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')]} 16:06:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:06:16 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')]} 16:06:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:06:16 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 0x234c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2515a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b8a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26bc090>, '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 0x26bcd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b6f90>, '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': '6d15e502d8e29d5d2676d664000001c3-1505860996.552136-1997593267', '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 16:06:16 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 16:06:16 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 16:06:16 INFO - Using env: {'DISPLAY': ':0', 16:06:16 INFO - 'HOME': '/home/cltbld', 16:06:16 INFO - 'LANG': 'en_US.UTF-8', 16:06:16 INFO - 'LANGUAGE': 'en_US:en', 16:06:16 INFO - 'LOGNAME': 'cltbld', 16:06:16 INFO - 'MAIL': '/var/mail/cltbld', 16:06:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:06:16 INFO - 'MOZ_NO_REMOTE': '1', 16:06:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:06:16 INFO - 'NO_EM_RESTART': '1', 16:06:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:06:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:06:16 INFO - 'PWD': '/builds/slave/test', 16:06:16 INFO - 'SHELL': '/bin/bash', 16:06:16 INFO - 'SHLVL': '1', 16:06:16 INFO - 'TERM': 'linux', 16:06:16 INFO - 'TMOUT': '86400', 16:06:16 INFO - 'USER': 'cltbld', 16:06:16 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1505860996.552136-1997593267', 16:06:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:06:16 INFO - '_': '/tools/buildbot/bin/python'} 16:06:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:06:16 INFO - Running setup.py (path:/tmp/pip-HI4mtO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:06:16 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)) 16:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:06:16 INFO - Running setup.py (path:/tmp/pip-GbKoV5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:06:16 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)) 16:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:06:16 INFO - Running setup.py (path:/tmp/pip-1aKaZ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:06:16 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)) 16:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:06:16 INFO - Running setup.py (path:/tmp/pip-K8yr8w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:06:16 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)) 16:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:06:16 INFO - Running setup.py (path:/tmp/pip-M8zjE2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:06:16 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)) 16:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:06:16 INFO - Running setup.py (path:/tmp/pip-hEw_ln-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:06:16 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)) 16:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:06:16 INFO - Running setup.py (path:/tmp/pip-hANab5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:06:17 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)) 16:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:06:17 INFO - Running setup.py (path:/tmp/pip-HH7RJK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:06:17 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)) 16:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:06:17 INFO - Running setup.py (path:/tmp/pip-spg2bH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:06:17 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)) 16:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:06:17 INFO - Running setup.py (path:/tmp/pip-QtG7Zq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:06:17 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)) 16:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:06:17 INFO - Running setup.py (path:/tmp/pip-rKcBnM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:06:17 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)) 16:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:06:17 INFO - Running setup.py (path:/tmp/pip-DuLxx8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:06:17 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)) 16:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:06:17 INFO - Running setup.py (path:/tmp/pip-kLk3Me-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:06:17 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)) 16:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:06:17 INFO - Running setup.py (path:/tmp/pip-UNJaN8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:06:17 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)) 16:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:06:17 INFO - Running setup.py (path:/tmp/pip-kaIYGQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:06:17 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)) 16:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:06:17 INFO - Running setup.py (path:/tmp/pip-1As4FN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:06:17 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)) 16:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:06:17 INFO - Running setup.py (path:/tmp/pip-SOrAPd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:06:17 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)) 16:06:17 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)) 16:06:17 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)) 16:06:17 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)) 16:06:17 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)) 16:06:17 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)) 16:06:17 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)) 16:06:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:06:17 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 16:06:17 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 16:06:17 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 16:06:17 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 16:06:18 INFO - Downloading blessings-1.6.tar.gz 16:06:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:06:18 INFO - Installing collected packages: blessings 16:06:18 INFO - Running setup.py install for blessings 16:06:19 INFO - Successfully installed blessings 16:06:19 INFO - Cleaning up... 16:06:19 INFO - Return code: 0 16:06:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:06:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:06:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:06:19 INFO - Reading from file tmpfile_stdout 16:06:19 INFO - Current package versions: 16:06:19 INFO - argparse == 1.2.1 16:06:19 INFO - blessings == 1.6 16:06:19 INFO - blobuploader == 1.2.4 16:06:19 INFO - docopt == 0.6.1 16:06:19 INFO - functools32 == 3.2.3-2 16:06:19 INFO - jsonschema == 2.5.1 16:06:19 INFO - manifestparser == 1.1 16:06:19 INFO - mozInstall == 1.13 16:06:19 INFO - mozcrash == 1.0 16:06:19 INFO - mozdebug == 0.1 16:06:19 INFO - mozdevice == 0.51 16:06:19 INFO - mozfile == 1.2 16:06:19 INFO - mozhttpd == 0.7 16:06:19 INFO - mozinfo == 0.10 16:06:19 INFO - mozleak == 0.1 16:06:19 INFO - mozlog == 3.5 16:06:19 INFO - moznetwork == 0.27 16:06:19 INFO - mozprocess == 0.25 16:06:19 INFO - mozprofile == 0.28 16:06:19 INFO - mozrunner == 6.13 16:06:19 INFO - mozscreenshot == 0.1 16:06:19 INFO - mozsystemmonitor == 0.3 16:06:19 INFO - moztest == 0.8 16:06:19 INFO - mozversion == 1.4 16:06:19 INFO - psutil == 3.1.1 16:06:19 INFO - requests == 1.2.3 16:06:19 INFO - wsgiref == 0.1.2 16:06:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:06:19 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')]} 16:06:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:06:19 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')]} 16:06:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:06:19 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 0x234c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2515a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b8a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26bc090>, '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 0x26bcd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b6f90>, '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': '6d15e502d8e29d5d2676d664000001c3-1505860996.552136-1997593267', '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 16:06:19 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 16:06:19 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 16:06:19 INFO - Using env: {'DISPLAY': ':0', 16:06:19 INFO - 'HOME': '/home/cltbld', 16:06:19 INFO - 'LANG': 'en_US.UTF-8', 16:06:19 INFO - 'LANGUAGE': 'en_US:en', 16:06:19 INFO - 'LOGNAME': 'cltbld', 16:06:19 INFO - 'MAIL': '/var/mail/cltbld', 16:06:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:06:19 INFO - 'MOZ_NO_REMOTE': '1', 16:06:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:06:19 INFO - 'NO_EM_RESTART': '1', 16:06:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:06:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:06:19 INFO - 'PWD': '/builds/slave/test', 16:06:19 INFO - 'SHELL': '/bin/bash', 16:06:19 INFO - 'SHLVL': '1', 16:06:19 INFO - 'TERM': 'linux', 16:06:19 INFO - 'TMOUT': '86400', 16:06:19 INFO - 'USER': 'cltbld', 16:06:19 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1505860996.552136-1997593267', 16:06:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:06:19 INFO - '_': '/tools/buildbot/bin/python'} 16:06:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:06:19 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)) 16:06:19 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)) 16:06:19 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)) 16:06:19 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)) 16:06:19 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)) 16:06:19 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)) 16:06:19 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)) 16:06:19 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)) 16:06:19 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)) 16:06:19 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 16:06:19 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 16:06:19 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 16:06:19 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 16:06:19 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 16:06:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 16:06:20 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)) 16:06:20 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)) 16:06:20 INFO - Installing collected packages: simplejson 16:06:20 INFO - Running setup.py install for simplejson 16:06:20 INFO - building 'simplejson._speedups' extension 16:06:20 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 16:06:21 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 16:06:21 INFO - Successfully installed simplejson 16:06:21 INFO - Cleaning up... 16:06:21 INFO - Return code: 0 16:06:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:06:21 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')]} 16:06:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:06:21 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')]} 16:06:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:06:21 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 0x234c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2515a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b8a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26bc090>, '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 0x26bcd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b6f90>, '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': '6d15e502d8e29d5d2676d664000001c3-1505860996.552136-1997593267', '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 16:06:21 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 16:06:21 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 16:06:21 INFO - Using env: {'DISPLAY': ':0', 16:06:21 INFO - 'HOME': '/home/cltbld', 16:06:21 INFO - 'LANG': 'en_US.UTF-8', 16:06:21 INFO - 'LANGUAGE': 'en_US:en', 16:06:21 INFO - 'LOGNAME': 'cltbld', 16:06:21 INFO - 'MAIL': '/var/mail/cltbld', 16:06:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:06:21 INFO - 'MOZ_NO_REMOTE': '1', 16:06:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:06:21 INFO - 'NO_EM_RESTART': '1', 16:06:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:06:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:06:21 INFO - 'PWD': '/builds/slave/test', 16:06:21 INFO - 'SHELL': '/bin/bash', 16:06:21 INFO - 'SHLVL': '1', 16:06:21 INFO - 'TERM': 'linux', 16:06:21 INFO - 'TMOUT': '86400', 16:06:21 INFO - 'USER': 'cltbld', 16:06:21 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1505860996.552136-1997593267', 16:06:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:06:21 INFO - '_': '/tools/buildbot/bin/python'} 16:06:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:06:22 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:06:22 INFO - Cleaning up... 16:06:22 INFO - Return code: 0 16:06:22 INFO - Running post-action listener: _resource_record_post_action 16:06:22 INFO - Running post-action listener: _start_resource_monitoring 16:06:22 INFO - Starting resource monitoring. 16:06:22 INFO - [mozharness: 2017-09-19 23:06:22.099969Z] Finished create-virtualenv step (success) 16:06:22 INFO - [mozharness: 2017-09-19 23:06:22.101015Z] Running install step. 16:06:22 INFO - Running pre-action listener: _resource_record_pre_action 16:06:22 INFO - Running main action method: install 16:06:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:06:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:06:22 INFO - Reading from file tmpfile_stdout 16:06:22 INFO - Detecting whether we're running mozinstall >=1.0... 16:06:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:06:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:06:22 INFO - Reading from file tmpfile_stdout 16:06:22 INFO - Output received: 16:06:22 INFO - Usage: mozinstall [options] installer 16:06:22 INFO - Options: 16:06:22 INFO - -h, --help show this help message and exit 16:06:22 INFO - -d DEST, --destination=DEST 16:06:22 INFO - Directory to install application into. [default: 16:06:22 INFO - "/builds/slave/test"] 16:06:22 INFO - --app=APP Application being installed. [default: firefox] 16:06:22 INFO - mkdir: /builds/slave/test/build/application 16:06:22 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'] 16:06:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 16:06:40 INFO - Reading from file tmpfile_stdout 16:06:40 INFO - Output received: 16:06:40 INFO - /builds/slave/test/build/application/firefox/firefox 16:06:40 INFO - Running post-action listener: _resource_record_post_action 16:06:40 INFO - [mozharness: 2017-09-19 23:06:40.300341Z] Finished install step (success) 16:06:40 INFO - [mozharness: 2017-09-19 23:06:40.300590Z] Running setup-mitmproxy step. 16:06:40 INFO - Running pre-action listener: _resource_record_pre_action 16:06:40 INFO - Running main action method: setup_mitmproxy 16:06:40 INFO - Skipping: mitmproxy is not required 16:06:40 INFO - Running post-action listener: _resource_record_post_action 16:06:40 INFO - [mozharness: 2017-09-19 23:06:40.301808Z] Finished setup-mitmproxy step (success) 16:06:40 INFO - [mozharness: 2017-09-19 23:06:40.302027Z] Running run-tests step. 16:06:40 INFO - Running pre-action listener: _resource_record_pre_action 16:06:40 INFO - Running pre-action listener: _set_gcov_prefix 16:06:40 INFO - Running main action method: run_tests 16:06:40 WARNING - Try message not found. 16:06:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:06:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:06:40 INFO - Python 2.7.3 16:06:40 INFO - Return code: 0 16:06:40 INFO - grabbing minidump binary from tooltool 16:06:40 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')]} 16:06:40 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 0x26bc090>, '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 0x26bcd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b6f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:06:40 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 16:06:40 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 16:06:40 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 16:06:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:06:40 INFO - Return code: 0 16:06:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:06:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:06:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:06:40 INFO - ENV: RUST_BACKTRACE is now full 16:06:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:06:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:06:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Y7gb7BDOTseBUm1jZrOsyg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] in /builds/slave/test/build 16:06:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Y7gb7BDOTseBUm1jZrOsyg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-023 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log 16:06:40 INFO - Using env: {'DISPLAY': ':0', 16:06:40 INFO - 'HOME': '/home/cltbld', 16:06:40 INFO - 'LANG': 'en_US.UTF-8', 16:06:40 INFO - 'LANGUAGE': 'en_US:en', 16:06:40 INFO - 'LOGNAME': 'cltbld', 16:06:40 INFO - 'MAIL': '/var/mail/cltbld', 16:06:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:06:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:06:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:06:40 INFO - 'MOZ_NO_REMOTE': '1', 16:06:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:06:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:06:40 INFO - 'NO_EM_RESTART': '1', 16:06:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:06:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:06:40 INFO - 'PWD': '/builds/slave/test', 16:06:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:06:40 INFO - 'RUST_BACKTRACE': 'full', 16:06:40 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:06:40 INFO - 'SHELL': '/bin/bash', 16:06:40 INFO - 'SHLVL': '1', 16:06:40 INFO - 'TERM': 'linux', 16:06:40 INFO - 'TMOUT': '86400', 16:06:40 INFO - 'USER': 'cltbld', 16:06:40 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1505860996.552136-1997593267', 16:06:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:06:40 INFO - '_': '/tools/buildbot/bin/python'} 16:06:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Y7gb7BDOTseBUm1jZrOsyg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] with output_timeout 3600 16:06:40 INFO - mozversion application_buildid: 20170919214925 16:06:40 INFO - mozversion application_changeset: a0eb21bf55e1c1ae0ba311e6f2273da05c712799 16:06:40 INFO - mozversion application_display_name: Nightly 16:06:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:06:40 INFO - mozversion application_name: Firefox 16:06:40 INFO - mozversion application_remotingname: firefox 16:06:40 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:06:40 INFO - mozversion application_vendor: Mozilla 16:06:40 INFO - mozversion application_version: 57.0a1 16:06:40 INFO - mozversion platform_buildid: 20170919214925 16:06:40 INFO - mozversion platform_changeset: a0eb21bf55e1c1ae0ba311e6f2273da05c712799 16:06:40 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:06:40 INFO - mozversion platform_version: 57.0a1 16:06:40 INFO - using testdate: 1505862400 16:06:40 INFO - actual date: 1505862400 16:06:40 INFO - starting webserver on 'localhost:60431' 16:06:40 INFO - SUITE-START | Running 2 tests 16:06:40 INFO - TEST-START | dromaeo_css 16:06:40 INFO - Initialising browser for dromaeo_css test... 16:06:40 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:60431/getInfo.html -profile /tmp/tmpOaxgel/profile 16:06:40 INFO - TEST-INFO | started process 3589 (/builds/slave/test/build/application/firefox/firefox http://localhost:60431/getInfo.html) 16:06:47 INFO - TEST-INFO | 3589: exit 0 16:06:47 INFO - Browser initialized. 16:06:47 INFO - Running cycle 1/1 for dromaeo_css test... 16:06:47 INFO - Using env: {'DISPLAY': ':0', 16:06:47 INFO - 'HOME': '/home/cltbld', 16:06:47 INFO - 'JSGC_DISABLE_POISONING': '1', 16:06:47 INFO - 'LANG': 'en_US.UTF-8', 16:06:47 INFO - 'LANGUAGE': 'en_US:en', 16:06:47 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 16:06:47 INFO - 'LOGNAME': 'cltbld', 16:06:47 INFO - 'MAIL': '/var/mail/cltbld', 16:06:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:06:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:06:47 INFO - 'MOZ_CRASHREPORTER': '1', 16:06:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:06:47 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 16:06:47 INFO - 'MOZ_NO_REMOTE': '1', 16:06:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:06:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:06:47 INFO - 'NO_EM_RESTART': '1', 16:06:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:06:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:06:47 INFO - 'PWD': '/builds/slave/test', 16:06:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:06:47 INFO - 'RUST_BACKTRACE': 'full', 16:06:47 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:06:47 INFO - 'SHELL': '/bin/bash', 16:06:47 INFO - 'SHLVL': '1', 16:06:47 INFO - 'STYLO_FORCE_DISABLED': '1', 16:06:47 INFO - 'TERM': 'linux', 16:06:47 INFO - 'TMOUT': '86400', 16:06:47 INFO - 'USER': 'cltbld', 16:06:47 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1505860996.552136-1997593267', 16:06:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:06:47 INFO - '_': '/tools/buildbot/bin/python'} 16:06:47 INFO - TEST-INFO | started process 3829 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOaxgel/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:06:48 INFO - PID 3829 | 16:06:48 INFO - PID 3829 | (/builds/slave/test/build/application/firefox/firefox:3879): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:06:48 INFO - PID 3829 | 16:06:58 INFO - PID 3829 | RSS: Main: 147460096 16:06:58 INFO - PID 3829 | 16:09:55 INFO - PID 3829 | Cycle 1(1): loaded http://localhost:60431/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60431/tests/dromaeo/cssquery-ext.html) 16:09:57 INFO - PID 3829 | RSS: Main: 148520960 16:09:57 INFO - PID 3829 | 16:12:58 INFO - PID 3829 | Cycle 1(1): loaded http://localhost:60431/tests/dromaeo/cssquery-ext.html (next: http://localhost:60431/tests/dromaeo/cssquery-jquery.html) 16:12:59 INFO - PID 3829 | RSS: Main: 148406272 16:12:59 INFO - PID 3829 | 16:16:00 INFO - PID 3829 | Cycle 1(1): loaded http://localhost:60431/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60431/tests/dromaeo/cssquery-mootools.html) 16:16:01 INFO - PID 3829 | RSS: Main: 150405120 16:16:01 INFO - PID 3829 | 16:19:03 INFO - PID 3829 | Cycle 1(1): loaded http://localhost:60431/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60431/tests/dromaeo/cssquery-prototype.html) 16:19:03 INFO - PID 3829 | RSS: Main: 148766720 16:19:03 INFO - PID 3829 | 16:22:06 INFO - PID 3829 | Cycle 1(1): loaded http://localhost:60431/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60431/tests/dromaeo/cssquery-yui.html) 16:22:07 INFO - PID 3829 | RSS: Main: 150568960 16:22:07 INFO - PID 3829 | 16:25:08 INFO - PID 3829 | Cycle 1(1): loaded http://localhost:60431/tests/dromaeo/cssquery-yui.html (next: http://localhost:60431/tests/dromaeo/cssquery-dojo.html) 16:25:08 INFO - PID 3829 | RSS: Main: 153104384 16:25:08 INFO - PID 3829 | 16:25:08 INFO - PID 3829 | __start_tp_report 16:25:08 INFO - PID 3829 | _x_x_mozilla_page_load 16:25:08 INFO - PID 3829 | _x_x_mozilla_page_load_details 16:25:08 INFO - PID 3829 | |i|pagename|runs| 16:25:08 INFO - PID 3829 | |0;dojo.html;3891.6302951219623;3900.258950799349;3906.8827935161944;3917.9216415671704;3945.151792364641;6248.437640612344;6342.334054924236;6397;6408.743650253996;6415.230172379309;6315.873682526347;6353.587016843902;6374;6477.54657173998;6511.120998665178;5744.22452968848;5747.626404283729;5750.281214848144;5758.136279558068;5784.797532086378;5519.365272993617;5613.691246981435;5688.715564221793;5779.162021506879;5823.563232757539;5702.857428564277;5717;5736.541076713853;5798;5805.680687562182;5565.053940830028;5623.606347555632;5636.273044344794;5713.74288157034;5720.914186287209;5633.380328163898;5656.038473459522;5657.09486482165;5692.430756924316;5708.257926469574;6326.49388048955;6349.111124442582;6399.456046236076;6409.807705768834;6422.967885160591;6842.623655698934;6849.520533562652;6939.965300173467;6959.721611135548;6964.3732064113965;6750.291219421939;6844.2129155147295;6896.448284137307;6913.308669133096;7009.754658586976;6287.622742635456;6311.400416960428;6332.208473940757;6346.048092786119;6346.428821406095;6916.896246556305;7029.156501219886;7142.642867856586;7146.92853071473;7155.356017958408;6769.120014398097;6773.221079575814;6847.863042739217;6870.20992585859;6873;6774.45804335652;6872.41584465326;6924.896126558106;6929.514933954676;7013.298670133048;6805.081314022643;6807.047013418125;6827.146606674166;6829.795106146824;6891.552049116792;6853.862922741617;6930.722771089201;6964.93035069653;6965.721371145199;6969.05917701114;4937.925931111036;4940.8764780880765;5007.499250074963;5015.247712843103;5015.749212539358;4488.932666010012;4513.480949690827;4544.068465964469;4565.406497155349;4622.46841613212;6326.778562750282;6333.1766870306565;6334.176557047646;6350;6371.585846919936;6739.224989126215;6829.726810927507;6932.029515867783;6944.236134025253;6953.061336719478;6224.533160013018;6232.906506402408;6257.843553911189;6272.498200143978;6286.748530058747;5379.6234263601955;5484.341878974469;5489.258950041693;5569.777208911679;5571.275734154534;7062.364387205176;7064.752733654297;7144.285571442814;7157.606331651705;7160.140783105957;6851.07510486078;6852.246252912076;6951.2353641098425;6952.096227490394;6978.511504194657;6910.516263861481;7003.264657211123;7028.50800443964;7044.295570442915;7083.82290442743;6789.626570538668;6870.244273130052;6881.208661004049;6888.41448476885;6890.10428644273;6907.551009184387;6908.378245957888;6990.825229369307;6995.615241161581;7004.019437278887;6464.127342808661;6535.085088087767;6600.768973085919;6605.207375115017;6634.038064480526;6559.27847936717;6598.406143447113;6600.900986485302;6605.438537724347;6686.498512611671;6484.319146489551;6628.038934354588;6652;6664.133662623828;6665.0335701324;6635.203775546772;6719.428848547733;6743.224529179207;6755.088063111613;6786.3892249697765;6351.93648063532;6427.517936154713;6459.257185423548;6463.289038205888;6587.242467116343 16:25:08 INFO - PID 3829 | |1;ext.html;911.5897845969315;938.3900464697941;960.9615615375383;991.2763682511769;1012.0537297626724;44475;44822;45486.772566137166;45495;45504.08991820166;43326.783366083204;43514.347284790754;43622.34566481497;43736;43815;7603.125640551324;7724.382049436032;7727.536347819121;7729.690812367527;7759.767206983771;7683.961580192119;7697.652910740626;7777.922220777777;7779.8833017504785;7781.727639532589;8229.094799572042;8479.788005299886;8480.575971201446;8482.87275690862;8553.700620478285;8361.414700970934;8413.411061225717;8422.031466381353;8498.830023399498;8500.404971651988;8139.104698483162;8303.211194936472;8313.584320783997;8360.080391156967;8449.915500844974;41457.585424145975;41863.37204941928;41900.37149442761;41925.79037104826;42242;3718.72109591779;3772.9434058489146;3773.6792372648356;3779.4519794629623;3783.1677031053123;34094;34147.14632134192;34199.6580034199;34240.48639270413;34245.143871403416;5435.347758269033;5476.726163691799;5489.451054894518;5540.556755459554;5589.860253493654;204711;205896;218690;219027;219107;53644.85420583133;53839.730801345744;53918;55390;55939;55481;55619.721901390236;55829.44170558324;55871.44128558744;55894;16443.83556164423;16471.83528164703;16567.834321656872;16578.336866525206;16580.917095414687;13465.865341346656;13515;13515.526956556474;13522.661933451545;13523.66190845217;15162.924185379003;15225.390984360723;15242.323344432103;15277.847221527643;15384.615384615474;6196.225471816023;6246.75012999484;6290.2766181889665;6291.276503202099;6326.5255105867245;1109.8834622364698;1115.59838458155;1117.3016864459712;1123.0341905960868;1127.9605213817476;26219.606705899427;26324.60513092305;26336.473270534865;26408.20775376742;26445.33886652849;1174.2895548193221;1199.1066655341826;1200.6098018143964;1213;1214.5384753793678;13441.932790335986;13450.058495905192;13815.723685526435;13997.860021399656;14017.71964560703;302346;302864;303214;303952;305194;59454.702726486954;59493.405065948784;59707.40292597105;59755.70122149361;60047.69976150179;1503.8345781964194;1525.603343130794;1541.884358673104;1545.2737213509633;1550.689862027599;24904.37739056538;24911.377215569755;25080.247592572254;25197.74802251954;25290.36774080663;40571.7971410141;40624.1875162501;40659.3901091478;40677.796611016754;40691.7965410171;253097;254594;254841;254859;255342;34154.48768268428;34159;36912.44631330478;37278.44082338713;37946.810265948494;47523;47527.287090692975;47532.7623361881;47606.52393476159;47930;33690.32619347648;34573.13567160741;34684.30631387408;34752.826235868655;35154;34244.82877585596;34336.31327373389;34362.656373435944;34364.26116838448;34542.48186277158;41237.1752564953;41329.58670413258;41486.17027659369;41509.37735934024;41675.16649667051;33630.327393452484;33632.3273534523;33643.3271334567;33980;34218.65781342254;25885;25900.61149082803;26124.73875261223;26126.73873261243;26544.070957516393 16:25:08 INFO - PID 3829 | |2;jquery.html;596.1370716510903;606.4935778624848;615.664462867737;630.79814459373;638.8051644248504;23275.883620581895;23443.765562344415;23969.400764980885;23995.880020599874;24052.759472405272;26078.348041298977;27066.05268815592;27193;27227.727722722768;27262.182134535997;6418.807435776934;6548.214214294268;6549.57427767196;6558.21301443825;6559.442447391977;6524.739010439576;6746.257911629717;6803.863922721543;6809.625470599115;6809.897851532231;6696.8995465068065;6713.060171575983;6729.427998620124;6731.293214212511;6734.966325168367;6683.766068187614;6708.362705543014;6712.429443497309;6722.193336799591;6746.8313292167595;6256.374362563753;6264.060390941349;6296.811095667137;6299.65351905645;6328.430441260262;27522.633251393825;30794.69205307963;31022.844885775652;31533.896313628913;31733.365332693447;2254.729432468098;2281.7604151564015;2283.977160228393;2285.5543169082034;2291.942701432461;20945.790542094535;21202.469938251514;21212.893935530377;21247.36257912265;21264;2411.9517609647883;2465.3097132802845;2480.454300053985;2502.0367158644053;2510.1465501729317;133450;139552.30223848918;151652;160228;165943.170284149;16027.919860400623;16927.730420218533;16950.745738813926;17008.57478563021;17122.486325410257;26189.869050655005;26247;26259.343516412242;26273;26321.07876224323;10249.487525623837;10337.586496540205;10384;10450.947745261377;10608.098311643442;9379.5310234488;9392.530373481299;9430.151286384258;9476.857847132298;9590.760230994141;9737.756556086155;10050.64822731201;10140.847887281696;10257.794844103077;10357.533910974023;2785.9442811143663;2801.4257077299103;2802.859857007182;2803.7383177570173;2805.8456784877026;1018.2159737002466;1048.0410424461684;1053.478528128566;1062.877769056553;1066.6213494209599;21699.45751356197;21895;22112.22607208772;22318.21886233974;22361;1086.5708045322053;1097.6926460591046;1110.6723516562633;1111.4276147783899;1118.8937050980144;12092.395380230953;12359.567415140607;12426;12435.37823108859;12472.126951113516;662714;663120;674704;682728;703337;127738;131734.34132829466;134379.32810335886;134396;134480.3275983614;1204.7710934922336;1209.176627221873;1232.648695121904;1235.2464996352219;1238.8079847623633;19763.40709778709;19844.10701518464;19902.800971990095;20129.094190761745;20166;59140.40859591349;60898.695506522185;62091.068633969626;62436.687816560625;62928.685356572925;82825;83009;83288;83845.58077209575;83897;15725.528234152993;15930.36278548845;16160.595985099997;16163.919180404022;16203.594910127342;24477.755222447548;24758.752412475646;24919.127830525846;24935.625965610892;25122.37194070163;19574.314898978468;19669.50826229356;20118.698219526425;20465.38603841887;20520.486987825425;17095.829041709425;17137.571560710585;17595.472135835946;17989.19048642788;18236.45290641283;19921.302754403525;20455.693164602246;20541.178352865718;20622.793772062687;20859;15601.765973510179;15740.60648483797;15767.211639418212;15824;15931.761023584888;19597;19732.50668733293;19754.90122549378;19764;19923.10346034461 16:25:08 INFO - PID 3829 | |3;mootools.html;1392.303848075962;1470.5735336752343;1488.360005197766;1494.5516345096469;1504.909705417675;16671.749923751155;17380.39168629097;17413.912930435363;17415.042172680496;17428;17114.400995965145;17213.397531086383;17224.56938576533;17245.655086898256;17254.2235599398;2873.74136327731;2893.5370340745485;2928.4289563535117;2928.780341474387;2929.033418971745;2788.9023884164058;2816.239615303877;2831.603575499432;2845.544712845945;2847.387811620501;2801.4677211329886;2883.09182607478;2893.6961619030017;2898.0291602313146;2900.013995241628;2821.6755073166437;2823.4635419270376;2851.7433430991105;2857.185702074909;2859.0850927703145;2695.3935364543017;2808.1154436352485;2812.9437411251865;2815.155453363983;2823.0966090850934;16941.83058169427;17080.743788843178;17090.31638734449;17107.31570737169;17111.14444277781;7799.805004874924;8085.555294458803;8086.312663423557;8087.393445491612;8090.271875531231;5403.486668766461;5601.551875849922;5658.688772117532;5750.30996280449;5754.625949313281;2147.516808718026;2171.6742488626674;2177.7495588007423;2182.7271591051117;2204.9448763780874;30448.84775576108;30795.846020769975;30803.383932321227;30808.845955770303;30838;7092.858142837114;7297.525660832135;7312.926870731331;7465.06686664167;7476.813079673052;17317.653646926992;17807;19652.803471965384;19681.11434985429;19689.11398987049;8463.195996380335;8654.524001179869;8656.701494775834;8727.650893964297;8742.694005709769;7846.568438735924;7926.365890728844;7981.1220765715725;8036.799080023046;8098.5545794981845;5613.7193140342815;5624.128260119606;5752.798652047159;5787.045137552257;5821.650700957956;1623.983760162407;1650.1996531682125;1664.9916750416412;1667.1414221675846;1690.4083570750386;989.678354534779;992.8808542974889;993.5032483758121;997.6258902911409;1011.600417834951;8650.562161892678;8720.476771393609;8730.65077396897;8898;8928.241099506486;810.5136917849243;811.2293321344746;814.2712272516065;816.8366326734676;826.7519744076753;5333.439988801198;5423.972880135653;6152.723127459275;6270.498360131179;6290.716917738713;24730.876345618155;24812.875935620566;25145.622815657778;25587.23238302854;25787.742122578908;24088.552054248037;24893.377665558142;25001.4999700005;25025.874870625896;25288.494230115295;11562.537498500134;11694.181407301407;11787.764244715057;11850.229735067365;11909.583164589198;9414.62341506332;9465.858012129962;9694.563744631367;9696.175825054666;9794.16749576294;21000.054997524843;21158;21166.365009049754;21375.25186618523;21592.244271450425;21502.462438439165;21996.340109796733;22150.446238844157;22174.445638858513;22218.555628887007;12473.064520160842;12531.624051278477;12590.181638193488;12602;12617.053720971147;15521.301541430437;15646.843531564538;15694.607634809221;15770.68458630844;15848.60378490547;12564;12915.870841291468;13173.341332933507;13177.73644527085;13184.340782960622;12290.262584244974;12321.258460142004;12384.690382740504;12663.113582049167;12808.231506109663;10945.398003109905;10988.615398461016;11147.888521114684;11160.944195278971;11225.831612525655;8086.393520485869;8105.351571874354;8229.629666664894;8256.793580160544;8267.83464330722;7836;7975.601219938864;8008.919910800817;8099.878501822595;8105.918940810517 16:25:08 INFO - PID 3829 | |4;prototype.html;535.8660334916271;556.0741365626233;559.6753882748006;572.9140628905664;582.8251524542637;6366.172397588312;6380.840478988028;6397.840053998652;6418.454431373327;6458.320836582488;6257.655828929407;6315.147455093561;6321.810345689625;6330.512329602551;6381.680915954195;5171.870703232412;5190.221466779994;5204.869878253036;5205.427402985669;5224.817131400402;5166.922496162541;5215.791368345262;5219.530242278194;5237.79048838046;5244.475552444763;4822.397200349957;4930.137225985456;5006.599472042228;5040.621953353513;5158.432572417031;5001.274815151783;5009.674371165863;5019.222020586815;5024.874378140576;5037.49625037497;4537.682362234645;4557.703749256288;4573.016801387685;4579.496255411902;4600.585947264729;6115.510759139258;6146.7541298348015;6179.28938172107;6190.752369905198;6232.909240882873;5863.2670916135485;5875.559333049996;5881.147233651097;5936.1095835625;5951.196588460546;6660.9000864987065;6665.366790154976;6672.799816005528;6696.459814242751;6749.7300107995625;5084.644074914758;5084.932164245476;5105.749091472613;5106.795728170869;5123.257127716498;6721.899171512431;6893.379595836349;6939.340762627542;6958.7912362628695;6971.4771392145285;5203.505666961632;5216.947830521646;5225.555827754683;5253.605979551472;5263.999840030382;5263.6841789492755;5278.709670968057;5299.33758280215;5301.8866038131655;5301.893962120736;5854.326752423526;5866.7653293868625;5874.765009399662;5894.823155305347;5897.52819774417;6735.831604209836;6744.42672372844;6752.729890804313;6787.5588086774205;6805.863882722318;1790.4628611416522;1819.7179437187258;1838.1728222300019;1839.6136811269516;1841.327915310902;1238.7089034076985;1287.3563218390805;1287.3820566128124;1294.0747365633617;1303.0683061610994;6184.196054512884;6242;6249.78125765596;6283.151774510474;6289.182406287154;6645.867082658319;6690.799276021728;6839.076724642109;6867.690953907087;6915;6079.848003799941;6151.7539298428455;6169.413905678954;6209.602839361108;6298.205011571772;3551.6803487686234;3561.982190089033;3581.4448760442174;3588.2105936693883;3594.5327107476382;6914.965425172943;6935.3411425914455;6991.335823096798;7024.332688394595;7034.296570343027;6971.407430368374;6997.370236678723;7017.508774385846;7018.473614478832;7025.262347453444;6822.624755638488;6912.68191268184;6950.965245173742;6988.113209433424;7015.3864611139725;6745.831354216184;6749.628770417674;6751.324867513209;6798.354156355138;6855;6649.867002660017;6676.155517267289;6690.531662783558;6707.295733947865;6750.86498270022;6909.170899492093;6931.480138989495;6950.826229344307;6955.582665040114;6982.825429364307;4999.475160076212;5103.770330335218;5121.8719532012;5157.638965272395;5177.611679124006;6620.172478440195;6811.557248778813;6811.739828131812;6812.420944219797;6839.89740153908;6332.30344662096;6658.766943156967;6671.799846004627;6713.899291510534;6726.730930762715;6627.933720662924;6670.866582668223;6710.429613482908;6716.3955244028275;6717.227518835396;6483.7730679425995;6494.6227961458835;6533.575317604341;6539.901901471387;6544.738210471528;6629.270780214076;6681.732730690718;6695.296993815774;6751.56114852533;6756.966215168893;6508.869822603616;6551.148350714377;6562.639054851838;6565.704543295467;6590.604563726191 16:25:08 INFO - PID 3829 | |5;yui.html;964.1419136968095;966.6423423333367;982.4645568165349;988.2489308125827;990.7325022243995;22530.77469225307;23492;24860;24870.50258994819;25127.49745005099;22909.4272643184;23129.768702312973;23859.28422147334;23868.403289917762;23959.161429349977;1058.9417582033004;1080.7730376620918;1081.378207530669;1081.464674985883;1081.913446924248;1070.5129166229385;1088.1131877519836;1088.9237753357268;1091.0398849012859;1100.6918062942389;1127.8421021057018;1130.9717257068598;1131.9151063670217;1132;1132.30363326554;1135.7444574970607;1137.7269455330743;1137.954481820722;1138.1975707126496;1138.618562781469;836.021854430318;837.3803385494751;837.6691206973211;837.7486753973783;838.4927119092922;18853.62292754151;18978.90510547452;18980.5254868628;18982.62034759311;19739.80260197394;23228.88385558078;23778.16776412817;23846.52306953851;23870.76129238703;23879;18221;18263;18353.63292734151;18409.171587278604;18415.72376414355;3862.748921320105;3924.097457584743;3936.8622098226424;3968.0873399118364;3972.8410863565423;157035;160465;161681;161736.19131904384;162721;17666.734998975026;17950.820491795177;18016.819831801513;18052.91682499054;18141.274349026156;34624.653753462146;34713.479297810554;34787.478187827204;34854.30291394158;34964.300713986086;8596.656133754579;8788.296936245086;8829.64681412749;8875.423097498642;8886.555672216364;4596.931046034312;4624.514425985223;4651.651126165551;4659.767011649404;4673.485916549177;6082.2701275847185;6204.937950620436;6216.595921265103;6235.594686345373;6241.469475094577;992.8560358748085;1030.4796077980723;1051.7791263834526;1054.146141625286;1055.134789472625;693.4002088193677;703.8416356319788;705.2665228162756;712.803978905805;719.7301012120455;11774.70478247392;11948.441247002364;12258.14193006481;12738.490460381481;13037;704.6969802984663;708.2032713197652;718.0521711341084;721.1094298541298;726.3862036579083;5915.615484993462;5951.137085122633;6035.818925432244;6087.54343424245;6096.146539484475;148479;154266;154860;157164;158367;133990;134305;135048;135832.3208383952;139514;117757;119376.4031179856;119903.40048299702;119925;119942;10833.67498975032;10938.835917461403;10967.725806854893;11053.889461105286;11297.774044519228;55815.44184558102;56035.43964560302;57073.429265706814;58303.4169658298;58940.410595895206;70237;72167.27832721606;72641.6367918157;72661;74480.62759686167;16884.071376074433;16984.150792460576;17083.231254593822;17180.828191717923;17187.484375468757;17611.53438518634;17839;18435.72346414778;18528.351507697706;18552.907235463736;16158.192090395669;16373.508794736177;16401.753973690644;16406.179691015164;16460.506184814476;15364.539063828102;15579.922100389425;15616.843831561539;15631.218439078228;15844.366225351318;15662.76505852436;15679.921600391925;15736.842631573538;15746.133962632166;15863.286152122952;12757.936210318889;12861.871381286068;12864.742705145658;12943.288119153536;13243.072984890965;12652.114351995271;12851.100422970303;12933.611991640266;12951.028672849763;13000.479980800663 16:25:08 INFO - PID 3829 | __end_tp_report 16:25:08 INFO - PID 3829 | __start_cc_report 16:25:08 INFO - PID 3829 | _x_x_mozilla_cycle_collect,291 16:25:08 INFO - PID 3829 | __end_cc_report 16:25:08 INFO - PID 3829 | __startTimestamp1505863508876__endTimestamp 16:25:08 INFO - PID 3829 | 16:25:08 INFO - PID 3829 | ------- Summary: start ------- 16:25:08 INFO - PID 3829 | Number of tests: 6 16:25:08 INFO - PID 3829 | 16:25:08 INFO - PID 3829 | [#0] dojo.html Cycles:165 Average:6322.33 Median:6559.28 stddev:757.75 (11.6%) stddev-sans-first:735.69 16:25:08 INFO - PID 3829 | Values: 3891.6 3900.3 3906.9 3917.9 3945.2 6248.4 6342.3 6397.0 6408.7 6415.2 6315.9 6353.6 6374.0 6477.5 6511.1 5744.2 5747.6 5750.3 5758.1 5784.8 5519.4 5613.7 5688.7 5779.2 5823.6 5702.9 5717.0 5736.5 5798.0 5805.7 5565.1 5623.6 5636.3 5713.7 5720.9 5633.4 5656.0 5657.1 5692.4 5708.3 6326.5 6349.1 6399.5 6409.8 6423.0 6842.6 6849.5 6940.0 6959.7 6964.4 6750.3 6844.2 6896.4 6913.3 7009.8 6287.6 6311.4 6332.2 6346.0 6346.4 6916.9 7029.2 7142.6 7146.9 7155.4 6769.1 6773.2 6847.9 6870.2 6873.0 6774.5 6872.4 6924.9 6929.5 7013.3 6805.1 6807.0 6827.1 6829.8 6891.6 6853.9 6930.7 6964.9 6965.7 6969.1 4937.9 4940.9 5007.5 5015.2 5015.7 4488.9 4513.5 4544.1 4565.4 4622.5 6326.8 6333.2 6334.2 6350.0 6371.6 6739.2 6829.7 6932.0 6944.2 6953.1 6224.5 6232.9 6257.8 6272.5 6286.7 5379.6 5484.3 5489.3 5569.8 5571.3 7062.4 7064.8 7144.3 7157.6 7160.1 6851.1 6852.2 6951.2 6952.1 6978.5 6910.5 7003.3 7028.5 7044.3 7083.8 6789.6 6870.2 6881.2 6888.4 6890.1 6907.6 6908.4 6990.8 6995.6 7004.0 6464.1 6535.1 6600.8 6605.2 6634.0 6559.3 6598.4 6600.9 6605.4 6686.5 6484.3 6628.0 6652.0 6664.1 6665.0 6635.2 6719.4 6743.2 6755.1 6786.4 6351.9 6427.5 6459.3 6463.3 6587.2 16:25:08 INFO - PID 3829 | 16:25:08 INFO - PID 3829 | [#1] ext.html Cycles:180 Average:43680.66 Median:20525.69 stddev:67709.09 (329.9%) stddev-sans-first:67822.88 16:25:08 INFO - PID 3829 | Values: 911.6 938.4 961.0 991.3 1012.1 44475.0 44822.0 45486.8 45495.0 45504.1 43326.8 43514.3 43622.3 43736.0 43815.0 7603.1 7724.4 7727.5 7729.7 7759.8 7684.0 7697.7 7777.9 7779.9 7781.7 8229.1 8479.8 8480.6 8482.9 8553.7 8361.4 8413.4 8422.0 8498.8 8500.4 8139.1 8303.2 8313.6 8360.1 8449.9 41457.6 41863.4 41900.4 41925.8 42242.0 3718.7 3772.9 3773.7 3779.5 3783.2 34094.0 34147.1 34199.7 34240.5 34245.1 5435.3 5476.7 5489.5 5540.6 5589.9 204711.0 205896.0 218690.0 219027.0 219107.0 53644.9 53839.7 53918.0 55390.0 55939.0 55481.0 55619.7 55829.4 55871.4 55894.0 16443.8 16471.8 16567.8 16578.3 16580.9 13465.9 13515.0 13515.5 13522.7 13523.7 15162.9 15225.4 15242.3 15277.8 15384.6 6196.2 6246.8 6290.3 6291.3 6326.5 1109.9 1115.6 1117.3 1123.0 1128.0 26219.6 26324.6 26336.5 26408.2 26445.3 1174.3 1199.1 1200.6 1213.0 1214.5 13441.9 13450.1 13815.7 13997.9 14017.7 302346.0 302864.0 303214.0 303952.0 305194.0 59454.7 59493.4 59707.4 59755.7 60047.7 1503.8 1525.6 1541.9 1545.3 1550.7 24904.4 24911.4 25080.2 25197.7 25290.4 40571.8 40624.2 40659.4 40677.8 40691.8 253097.0 254594.0 254841.0 254859.0 255342.0 34154.5 34159.0 36912.4 37278.4 37946.8 47523.0 47527.3 47532.8 47606.5 47930.0 33690.3 34573.1 34684.3 34752.8 35154.0 34244.8 34336.3 34362.7 34364.3 34542.5 41237.2 41329.6 41486.2 41509.4 41675.2 33630.3 33632.3 33643.3 33980.0 34218.7 25885.0 25900.6 26124.7 26126.7 26544.1 16:25:08 INFO - PID 3829 | 16:25:08 INFO - PID 3829 | [#2] jquery.html Cycles:180 Average:42051.40 Median:2282.87 stddev:112638.49 (4934.1%) stddev-sans-first:112911.46 16:25:08 INFO - PID 3829 | Values: 596.1 606.5 615.7 630.8 638.8 23275.9 23443.8 23969.4 23995.9 24052.8 26078.3 27066.1 27193.0 27227.7 27262.2 6418.8 6548.2 6549.6 6558.2 6559.4 6524.7 6746.3 6803.9 6809.6 6809.9 6696.9 6713.1 6729.4 6731.3 6735.0 6683.8 6708.4 6712.4 6722.2 6746.8 6256.4 6264.1 6296.8 6299.7 6328.4 27522.6 30794.7 31022.8 31533.9 31733.4 2254.7 2281.8 2284.0 2285.6 2291.9 20945.8 21202.5 21212.9 21247.4 21264.0 2412.0 2465.3 2480.5 2502.0 2510.1 133450.0 139552.3 151652.0 160228.0 165943.2 16027.9 16927.7 16950.7 17008.6 17122.5 26189.9 26247.0 26259.3 26273.0 26321.1 10249.5 10337.6 10384.0 10450.9 10608.1 9379.5 9392.5 9430.2 9476.9 9590.8 9737.8 10050.6 10140.8 10257.8 10357.5 2785.9 2801.4 2802.9 2803.7 2805.8 1018.2 1048.0 1053.5 1062.9 1066.6 21699.5 21895.0 22112.2 22318.2 22361.0 1086.6 1097.7 1110.7 1111.4 1118.9 12092.4 12359.6 12426.0 12435.4 12472.1 662714.0 663120.0 674704.0 682728.0 703337.0 127738.0 131734.3 134379.3 134396.0 134480.3 1204.8 1209.2 1232.6 1235.2 1238.8 19763.4 19844.1 19902.8 20129.1 20166.0 59140.4 60898.7 62091.1 62436.7 62928.7 82825.0 83009.0 83288.0 83845.6 83897.0 15725.5 15930.4 16160.6 16163.9 16203.6 24477.8 24758.8 24919.1 24935.6 25122.4 19574.3 19669.5 20118.7 20465.4 20520.5 17095.8 17137.6 17595.5 17989.2 18236.5 19921.3 20455.7 20541.2 20622.8 20859.0 15601.8 15740.6 15767.2 15824.0 15931.8 19597.0 19732.5 19754.9 19764.0 19923.1 16:25:08 INFO - PID 3829 | 16:25:08 INFO - PID 3829 | [#3] mootools.html Cycles:180 Average:10451.34 Median:2814.05 stddev:7738.59 (275.0%) stddev-sans-first:7730.37 16:25:08 INFO - PID 3829 | Values: 1392.3 1470.6 1488.4 1494.6 1504.9 16671.7 17380.4 17413.9 17415.0 17428.0 17114.4 17213.4 17224.6 17245.7 17254.2 2873.7 2893.5 2928.4 2928.8 2929.0 2788.9 2816.2 2831.6 2845.5 2847.4 2801.5 2883.1 2893.7 2898.0 2900.0 2821.7 2823.5 2851.7 2857.2 2859.1 2695.4 2808.1 2812.9 2815.2 2823.1 16941.8 17080.7 17090.3 17107.3 17111.1 7799.8 8085.6 8086.3 8087.4 8090.3 5403.5 5601.6 5658.7 5750.3 5754.6 2147.5 2171.7 2177.7 2182.7 2204.9 30448.8 30795.8 30803.4 30808.8 30838.0 7092.9 7297.5 7312.9 7465.1 7476.8 17317.7 17807.0 19652.8 19681.1 19689.1 8463.2 8654.5 8656.7 8727.7 8742.7 7846.6 7926.4 7981.1 8036.8 8098.6 5613.7 5624.1 5752.8 5787.0 5821.7 1624.0 1650.2 1665.0 1667.1 1690.4 989.7 992.9 993.5 997.6 1011.6 8650.6 8720.5 8730.7 8898.0 8928.2 810.5 811.2 814.3 816.8 826.8 5333.4 5424.0 6152.7 6270.5 6290.7 24730.9 24812.9 25145.6 25587.2 25787.7 24088.6 24893.4 25001.5 25025.9 25288.5 11562.5 11694.2 11787.8 11850.2 11909.6 9414.6 9465.9 9694.6 9696.2 9794.2 21000.1 21158.0 21166.4 21375.3 21592.2 21502.5 21996.3 22150.4 22174.4 22218.6 12473.1 12531.6 12590.2 12602.0 12617.1 15521.3 15646.8 15694.6 15770.7 15848.6 12564.0 12915.9 13173.3 13177.7 13184.3 12290.3 12321.3 12384.7 12663.1 12808.2 10945.4 10988.6 11147.9 11160.9 11225.8 8086.4 8105.4 8229.6 8256.8 8267.8 7836.0 7975.6 8008.9 8099.9 8105.9 16:25:08 INFO - PID 3829 | 16:25:08 INFO - PID 3829 | [#4] prototype.html Cycles:180 Average:5678.89 Median:6306.68 stddev:1583.60 (25.1%) stddev-sans-first:1540.28 16:25:08 INFO - PID 3829 | Values: 535.9 556.1 559.7 572.9 582.8 6366.2 6380.8 6397.8 6418.5 6458.3 6257.7 6315.1 6321.8 6330.5 6381.7 5171.9 5190.2 5204.9 5205.4 5224.8 5166.9 5215.8 5219.5 5237.8 5244.5 4822.4 4930.1 5006.6 5040.6 5158.4 5001.3 5009.7 5019.2 5024.9 5037.5 4537.7 4557.7 4573.0 4579.5 4600.6 6115.5 6146.8 6179.3 6190.8 6232.9 5863.3 5875.6 5881.1 5936.1 5951.2 6660.9 6665.4 6672.8 6696.5 6749.7 5084.6 5084.9 5105.7 5106.8 5123.3 6721.9 6893.4 6939.3 6958.8 6971.5 5203.5 5216.9 5225.6 5253.6 5264.0 5263.7 5278.7 5299.3 5301.9 5301.9 5854.3 5866.8 5874.8 5894.8 5897.5 6735.8 6744.4 6752.7 6787.6 6805.9 1790.5 1819.7 1838.2 1839.6 1841.3 1238.7 1287.4 1287.4 1294.1 1303.1 6184.2 6242.0 6249.8 6283.2 6289.2 6645.9 6690.8 6839.1 6867.7 6915.0 6079.8 6151.8 6169.4 6209.6 6298.2 3551.7 3562.0 3581.4 3588.2 3594.5 6915.0 6935.3 6991.3 7024.3 7034.3 6971.4 6997.4 7017.5 7018.5 7025.3 6822.6 6912.7 6951.0 6988.1 7015.4 6745.8 6749.6 6751.3 6798.4 6855.0 6649.9 6676.2 6690.5 6707.3 6750.9 6909.2 6931.5 6950.8 6955.6 6982.8 4999.5 5103.8 5121.9 5157.6 5177.6 6620.2 6811.6 6811.7 6812.4 6839.9 6332.3 6658.8 6671.8 6713.9 6726.7 6627.9 6670.9 6710.4 6716.4 6717.2 6483.8 6494.6 6533.6 6539.9 6544.7 6629.3 6681.7 6695.3 6751.6 6757.0 6508.9 6551.1 6562.6 6565.7 6590.6 16:25:08 INFO - PID 3829 | 16:25:08 INFO - PID 3829 | [#5] yui.html Cycles:180 Average:28672.69 Median:18181.14 stddev:43419.81 (238.8%) stddev-sans-first:43491.77 16:25:08 INFO - PID 3829 | Values: 964.1 966.6 982.5 988.2 990.7 22530.8 23492.0 24860.0 24870.5 25127.5 22909.4 23129.8 23859.3 23868.4 23959.2 1058.9 1080.8 1081.4 1081.5 1081.9 1070.5 1088.1 1088.9 1091.0 1100.7 1127.8 1131.0 1131.9 1132.0 1132.3 1135.7 1137.7 1138.0 1138.2 1138.6 836.0 837.4 837.7 837.7 838.5 18853.6 18978.9 18980.5 18982.6 19739.8 23228.9 23778.2 23846.5 23870.8 23879.0 18221.0 18263.0 18353.6 18409.2 18415.7 3862.7 3924.1 3936.9 3968.1 3972.8 157035.0 160465.0 161681.0 161736.2 162721.0 17666.7 17950.8 18016.8 18052.9 18141.3 34624.7 34713.5 34787.5 34854.3 34964.3 8596.7 8788.3 8829.6 8875.4 8886.6 4596.9 4624.5 4651.7 4659.8 4673.5 6082.3 6204.9 6216.6 6235.6 6241.5 992.9 1030.5 1051.8 1054.1 1055.1 693.4 703.8 705.3 712.8 719.7 11774.7 11948.4 12258.1 12738.5 13037.0 704.7 708.2 718.1 721.1 726.4 5915.6 5951.1 6035.8 6087.5 6096.1 148479.0 154266.0 154860.0 157164.0 158367.0 133990.0 134305.0 135048.0 135832.3 139514.0 117757.0 119376.4 119903.4 119925.0 119942.0 10833.7 10938.8 10967.7 11053.9 11297.8 55815.4 56035.4 57073.4 58303.4 58940.4 70237.0 72167.3 72641.6 72661.0 74480.6 16884.1 16984.2 17083.2 17180.8 17187.5 17611.5 17839.0 18435.7 18528.4 18552.9 16158.2 16373.5 16401.8 16406.2 16460.5 15364.5 15579.9 15616.8 15631.2 15844.4 15662.8 15679.9 15736.8 15746.1 15863.3 12757.9 12861.9 12864.7 12943.3 13243.1 12652.1 12851.1 12933.6 12951.0 13000.5 16:25:08 INFO - PID 3829 | -------- Summary: end -------- 16:25:08 INFO - PID 3829 | 16:25:09 INFO - TEST-INFO | 3829: exit 0 16:25:09 INFO - TEST-OK | dromaeo_css | took 1108777ms 16:25:09 INFO - TEST-START | kraken 16:25:09 INFO - Initialising browser for kraken test... 16:25:09 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:60431/getInfo.html -profile /tmp/tmpA6iL5G/profile 16:25:09 INFO - TEST-INFO | started process 4204 (/builds/slave/test/build/application/firefox/firefox http://localhost:60431/getInfo.html) 16:25:14 INFO - TEST-INFO | 4204: exit 0 16:25:14 INFO - Browser initialized. 16:25:14 INFO - Running cycle 1/1 for kraken test... 16:25:14 INFO - Using env: {'DISPLAY': ':0', 16:25:14 INFO - 'HOME': '/home/cltbld', 16:25:14 INFO - 'JSGC_DISABLE_POISONING': '1', 16:25:14 INFO - 'LANG': 'en_US.UTF-8', 16:25:14 INFO - 'LANGUAGE': 'en_US:en', 16:25:14 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 16:25:14 INFO - 'LOGNAME': 'cltbld', 16:25:14 INFO - 'MAIL': '/var/mail/cltbld', 16:25:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:25:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:25:14 INFO - 'MOZ_CRASHREPORTER': '1', 16:25:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:25:14 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 16:25:14 INFO - 'MOZ_NO_REMOTE': '1', 16:25:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:25:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:25:14 INFO - 'NO_EM_RESTART': '1', 16:25:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:25:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:25:14 INFO - 'PWD': '/builds/slave/test', 16:25:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:25:14 INFO - 'RUST_BACKTRACE': 'full', 16:25:14 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:25:14 INFO - 'SHELL': '/bin/bash', 16:25:14 INFO - 'SHLVL': '1', 16:25:14 INFO - 'STYLO_FORCE_DISABLED': '1', 16:25:14 INFO - 'TERM': 'linux', 16:25:14 INFO - 'TMOUT': '86400', 16:25:14 INFO - 'USER': 'cltbld', 16:25:14 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1505860996.552136-1997593267', 16:25:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:25:14 INFO - '_': '/tools/buildbot/bin/python'} 16:25:14 INFO - TEST-INFO | started process 4440 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpA6iL5G/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:25:15 INFO - PID 4440 | 16:25:15 INFO - PID 4440 | (/builds/slave/test/build/application/firefox/firefox:4491): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:25:15 INFO - PID 4440 | 16:25:25 INFO - PID 4440 | RSS: Main: 147202048 16:25:25 INFO - PID 4440 | 16:25:28 INFO - PID 4440 | Cycle 1(1): loaded http://localhost:60431/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60431/tests/kraken/driver.html?testName=audio-beat-detection) 16:25:29 INFO - PID 4440 | RSS: Main: 152596480 16:25:29 INFO - PID 4440 | 16:25:31 INFO - PID 4440 | Cycle 1(1): loaded http://localhost:60431/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60431/tests/kraken/driver.html?testName=audio-dft) 16:25:32 INFO - PID 4440 | RSS: Main: 152940544 16:25:32 INFO - PID 4440 | 16:25:35 INFO - PID 4440 | Cycle 1(1): loaded http://localhost:60431/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60431/tests/kraken/driver.html?testName=audio-fft) 16:25:35 INFO - PID 4440 | RSS: Main: 149540864 16:25:35 INFO - PID 4440 | 16:25:37 INFO - PID 4440 | Cycle 1(1): loaded http://localhost:60431/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60431/tests/kraken/driver.html?testName=audio-oscillator) 16:25:38 INFO - PID 4440 | RSS: Main: 150704128 16:25:38 INFO - PID 4440 | 16:25:40 INFO - PID 4440 | Cycle 1(1): loaded http://localhost:60431/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60431/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:25:41 INFO - PID 4440 | RSS: Main: 150069248 16:25:41 INFO - PID 4440 | 16:25:44 INFO - PID 4440 | Cycle 1(1): loaded http://localhost:60431/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60431/tests/kraken/driver.html?testName=imaging-darkroom) 16:25:44 INFO - PID 4440 | RSS: Main: 150441984 16:25:44 INFO - PID 4440 | 16:25:48 INFO - PID 4440 | Cycle 1(1): loaded http://localhost:60431/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60431/tests/kraken/driver.html?testName=imaging-desaturate) 16:25:49 INFO - PID 4440 | RSS: Main: 151584768 16:25:49 INFO - PID 4440 | 16:25:51 INFO - PID 4440 | Cycle 1(1): loaded http://localhost:60431/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60431/tests/kraken/driver.html?testName=json-parse-financial) 16:25:52 INFO - PID 4440 | RSS: Main: 153333760 16:25:52 INFO - PID 4440 | 16:25:54 INFO - PID 4440 | Cycle 1(1): loaded http://localhost:60431/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60431/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:25:54 INFO - PID 4440 | RSS: Main: 153276416 16:25:54 INFO - PID 4440 | 16:25:56 INFO - PID 4440 | Cycle 1(1): loaded http://localhost:60431/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60431/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:25:56 INFO - PID 4440 | RSS: Main: 153055232 16:25:56 INFO - PID 4440 | 16:25:58 INFO - PID 4440 | Cycle 1(1): loaded http://localhost:60431/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60431/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:25:59 INFO - PID 4440 | RSS: Main: 150323200 16:25:59 INFO - PID 4440 | 16:26:01 INFO - PID 4440 | Cycle 1(1): loaded http://localhost:60431/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60431/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:26:02 INFO - PID 4440 | RSS: Main: 150945792 16:26:02 INFO - PID 4440 | 16:26:05 INFO - PID 4440 | Cycle 1(1): loaded http://localhost:60431/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60431/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:26:05 INFO - PID 4440 | RSS: Main: 151265280 16:26:05 INFO - PID 4440 | 16:26:07 INFO - PID 4440 | Cycle 1(1): loaded http://localhost:60431/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60431/tests/kraken/driver.html?testName=ai-astar) 16:26:07 INFO - PID 4440 | RSS: Main: 152584192 16:26:07 INFO - PID 4440 | 16:26:07 INFO - PID 4440 | __start_tp_report 16:26:07 INFO - PID 4440 | _x_x_mozilla_page_load 16:26:07 INFO - PID 4440 | _x_x_mozilla_page_load_details 16:26:07 INFO - PID 4440 | |i|pagename|runs| 16:26:07 INFO - PID 4440 | |0;ai-astar;106;105;107;106;106;95;107;106;106;107 16:26:07 INFO - PID 4440 | |1;audio-beat-detection;113;111;111;115;113;139;114;114;121;111 16:26:07 INFO - PID 4440 | |2;audio-dft;163;162;163;163;163;163;161;165;165;170 16:26:07 INFO - PID 4440 | |3;audio-fft;75;72;73;73;73;73;74;76;76;77 16:26:07 INFO - PID 4440 | |4;audio-oscillator;79;78;78;77;76;78;78;78;78;82 16:26:07 INFO - PID 4440 | |5;imaging-gaussian-blur;110;114;113;117;113;114;114;114;114;116 16:26:07 INFO - PID 4440 | |6;imaging-darkroom;149;149;149;151;151;150;152;151;149;149 16:26:07 INFO - PID 4440 | |7;imaging-desaturate;93;93;94;94;93;94;93;94;94;94 16:26:07 INFO - PID 4440 | |8;json-parse-financial;43;44;44;44;44;44;43;43;44;44 16:26:07 INFO - PID 4440 | |9;json-stringify-tinderbox;39;39;39;39;42;38;38;38;39;39 16:26:07 INFO - PID 4440 | |10;stanford-crypto-aes;71;71;74;73;82;73;75;72;73;73 16:26:07 INFO - PID 4440 | |11;stanford-crypto-ccm;114;104;104;110;109;104;105;109;110;109 16:26:07 INFO - PID 4440 | |12;stanford-crypto-pbkdf2;151;151;165;159;152;163;157;151;156;155 16:26:07 INFO - PID 4440 | |13;stanford-crypto-sha256-iterative;66;63;60;59;60;61;65;59;59;58 16:26:07 INFO - PID 4440 | __end_tp_report 16:26:07 INFO - PID 4440 | __start_cc_report 16:26:07 INFO - PID 4440 | _x_x_mozilla_cycle_collect,704 16:26:07 INFO - PID 4440 | __end_cc_report 16:26:07 INFO - PID 4440 | __startTimestamp1505863567806__endTimestamp 16:26:07 INFO - PID 4440 | 16:26:07 INFO - PID 4440 | ------- Summary: start ------- 16:26:07 INFO - PID 4440 | Number of tests: 14 16:26:07 INFO - PID 4440 | 16:26:07 INFO - PID 4440 | [#0] ai-astar Cycles:10 Average:105.10 Median:106.50 stddev:3.60 (3.4%) stddev-sans-first:3.81 16:26:07 INFO - PID 4440 | Values: 106.0 105.0 107.0 106.0 106.0 95.0 107.0 106.0 106.0 107.0 16:26:07 INFO - PID 4440 | 16:26:07 INFO - PID 4440 | [#1] audio-beat-detection Cycles:10 Average:116.20 Median:114.00 stddev:8.53 (7.5%) stddev-sans-first:8.97 16:26:07 INFO - PID 4440 | Values: 113.0 111.0 111.0 115.0 113.0 139.0 114.0 114.0 121.0 111.0 16:26:07 INFO - PID 4440 | 16:26:07 INFO - PID 4440 | [#2] audio-dft Cycles:10 Average:163.80 Median:163.00 stddev:2.49 (1.5%) stddev-sans-first:2.62 16:26:07 INFO - PID 4440 | Values: 163.0 162.0 163.0 163.0 163.0 163.0 161.0 165.0 165.0 170.0 16:26:07 INFO - PID 4440 | 16:26:07 INFO - PID 4440 | [#3] audio-fft Cycles:10 Average:74.20 Median:74.50 stddev:1.69 (2.3%) stddev-sans-first:1.76 16:26:07 INFO - PID 4440 | Values: 75.0 72.0 73.0 73.0 73.0 73.0 74.0 76.0 76.0 77.0 16:26:07 INFO - PID 4440 | 16:26:07 INFO - PID 4440 | [#4] audio-oscillator Cycles:10 Average:78.20 Median:78.00 stddev:1.55 (2.0%) stddev-sans-first:1.62 16:26:07 INFO - PID 4440 | Values: 79.0 78.0 78.0 77.0 76.0 78.0 78.0 78.0 78.0 82.0 16:26:07 INFO - PID 4440 | 16:26:07 INFO - PID 4440 | [#5] imaging-gaussian-blur Cycles:10 Average:113.90 Median:114.00 stddev:1.85 (1.6%) stddev-sans-first:1.32 16:26:07 INFO - PID 4440 | Values: 110.0 114.0 113.0 117.0 113.0 114.0 114.0 114.0 114.0 116.0 16:26:07 INFO - PID 4440 | 16:26:07 INFO - PID 4440 | [#6] imaging-darkroom Cycles:10 Average:150.00 Median:150.50 stddev:1.15 (0.8%) stddev-sans-first:1.17 16:26:07 INFO - PID 4440 | Values: 149.0 149.0 149.0 151.0 151.0 150.0 152.0 151.0 149.0 149.0 16:26:07 INFO - PID 4440 | 16:26:07 INFO - PID 4440 | [#7] imaging-desaturate Cycles:10 Average:93.60 Median:94.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 16:26:07 INFO - PID 4440 | Values: 93.0 93.0 94.0 94.0 93.0 94.0 93.0 94.0 94.0 94.0 16:26:07 INFO - PID 4440 | 16:26:07 INFO - PID 4440 | [#8] json-parse-financial Cycles:10 Average:43.70 Median:44.00 stddev:0.48 (1.1%) stddev-sans-first:0.44 16:26:07 INFO - PID 4440 | Values: 43.0 44.0 44.0 44.0 44.0 44.0 43.0 43.0 44.0 44.0 16:26:07 INFO - PID 4440 | 16:26:07 INFO - PID 4440 | [#9] json-stringify-tinderbox Cycles:10 Average:39.00 Median:39.00 stddev:1.15 (3.0%) stddev-sans-first:1.22 16:26:07 INFO - PID 4440 | Values: 39.0 39.0 39.0 39.0 42.0 38.0 38.0 38.0 39.0 39.0 16:26:07 INFO - PID 4440 | 16:26:07 INFO - PID 4440 | [#10] stanford-crypto-aes Cycles:10 Average:73.70 Median:73.00 stddev:3.16 (4.3%) stddev-sans-first:3.20 16:26:07 INFO - PID 4440 | Values: 71.0 71.0 74.0 73.0 82.0 73.0 75.0 72.0 73.0 73.0 16:26:07 INFO - PID 4440 | 16:26:07 INFO - PID 4440 | [#11] stanford-crypto-ccm Cycles:10 Average:107.80 Median:109.00 stddev:3.39 (3.1%) stddev-sans-first:2.76 16:26:07 INFO - PID 4440 | Values: 114.0 104.0 104.0 110.0 109.0 104.0 105.0 109.0 110.0 109.0 16:26:07 INFO - PID 4440 | 16:26:07 INFO - PID 4440 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.00 Median:156.50 stddev:5.08 (3.2%) stddev-sans-first:5.05 16:26:07 INFO - PID 4440 | Values: 151.0 151.0 165.0 159.0 152.0 163.0 157.0 151.0 156.0 155.0 16:26:07 INFO - PID 4440 | 16:26:07 INFO - PID 4440 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.00 Median:60.50 stddev:2.75 (4.5%) stddev-sans-first:2.24 16:26:07 INFO - PID 4440 | Values: 66.0 63.0 60.0 59.0 60.0 61.0 65.0 59.0 59.0 58.0 16:26:07 INFO - PID 4440 | -------- Summary: end -------- 16:26:07 INFO - PID 4440 | 16:26:08 INFO - PID 4440 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 16:26:08 INFO - TEST-INFO | 4440: exit 0 16:26:08 INFO - TEST-OK | kraken | took 59040ms 16:26:08 INFO - SUITE-END | took 1167s 16:26:08 INFO - Completed test suite (00:19:28) 16:26:08 INFO - javascript benchmark 16:26:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9110.827788466742, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3891.6302951219623, 3900.258950799349, 3906.8827935161944, 3917.9216415671704, 3945.151792364641, 6248.437640612344, 6342.334054924236, 6397.0, 6408.743650253996, 6415.230172379309, 6315.873682526347, 6353.587016843902, 6374.0, 6477.54657173998, 6511.120998665178, 5744.22452968848, 5747.626404283729, 5750.281214848144, 5758.136279558068, 5784.797532086378, 5519.365272993617, 5613.691246981435, 5688.715564221793, 5779.162021506879, 5823.563232757539, 5702.857428564277, 5717.0, 5736.541076713853, 5798.0, 5805.680687562182, 5565.053940830028, 5623.606347555632, 5636.273044344794, 5713.74288157034, 5720.914186287209, 5633.380328163898, 5656.038473459522, 5657.09486482165, 5692.430756924316, 5708.257926469574, 6326.49388048955, 6349.111124442582, 6399.456046236076, 6409.807705768834, 6422.967885160591, 6842.623655698934, 6849.520533562652, 6939.965300173467, 6959.721611135548, 6964.3732064113965, 6750.291219421939, 6844.2129155147295, 6896.448284137307, 6913.308669133096, 7009.754658586976, 6287.622742635456, 6311.400416960428, 6332.208473940757, 6346.048092786119, 6346.428821406095, 6916.896246556305, 7029.156501219886, 7142.642867856586, 7146.92853071473, 7155.356017958408, 6769.120014398097, 6773.221079575814, 6847.863042739217, 6870.20992585859, 6873.0, 6774.45804335652, 6872.41584465326, 6924.896126558106, 6929.514933954676, 7013.298670133048, 6805.081314022643, 6807.047013418125, 6827.146606674166, 6829.795106146824, 6891.552049116792, 6853.862922741617, 6930.722771089201, 6964.93035069653, 6965.721371145199, 6969.05917701114, 4937.925931111036, 4940.8764780880765, 5007.499250074963, 5015.247712843103, 5015.749212539358, 4488.932666010012, 4513.480949690827, 4544.068465964469, 4565.406497155349, 4622.46841613212, 6326.778562750282, 6333.1766870306565, 6334.176557047646, 6350.0, 6371.585846919936, 6739.224989126215, 6829.726810927507, 6932.029515867783, 6944.236134025253, 6953.061336719478, 6224.533160013018, 6232.906506402408, 6257.843553911189, 6272.498200143978, 6286.748530058747, 5379.6234263601955, 5484.341878974469, 5489.258950041693, 5569.777208911679, 5571.275734154534, 7062.364387205176, 7064.752733654297, 7144.285571442814, 7157.606331651705, 7160.140783105957, 6851.07510486078, 6852.246252912076, 6951.2353641098425, 6952.096227490394, 6978.511504194657, 6910.516263861481, 7003.264657211123, 7028.50800443964, 7044.295570442915, 7083.82290442743, 6789.626570538668, 6870.244273130052, 6881.208661004049, 6888.41448476885, 6890.10428644273, 6907.551009184387, 6908.378245957888, 6990.825229369307, 6995.615241161581, 7004.019437278887, 6464.127342808661, 6535.085088087767, 6600.768973085919, 6605.207375115017, 6634.038064480526, 6559.27847936717, 6598.406143447113, 6600.900986485302, 6605.438537724347, 6686.498512611671, 6484.319146489551, 6628.038934354588, 6652.0, 6664.133662623828, 6665.0335701324, 6635.203775546772, 6719.428848547733, 6743.224529179207, 6755.088063111613, 6786.3892249697765, 6351.93648063532, 6427.517936154713, 6459.257185423548, 6463.289038205888, 6587.242467116343], "value": 6270.435171526689, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [911.5897845969315, 938.3900464697941, 960.9615615375383, 991.2763682511769, 1012.0537297626724, 44475.0, 44822.0, 45486.772566137166, 45495.0, 45504.08991820166, 43326.783366083204, 43514.347284790754, 43622.34566481497, 43736.0, 43815.0, 7603.125640551324, 7724.382049436032, 7727.536347819121, 7729.690812367527, 7759.767206983771, 7683.961580192119, 7697.652910740626, 7777.922220777777, 7779.8833017504785, 7781.727639532589, 8229.094799572042, 8479.788005299886, 8480.575971201446, 8482.87275690862, 8553.700620478285, 8361.414700970934, 8413.411061225717, 8422.031466381353, 8498.830023399498, 8500.404971651988, 8139.104698483162, 8303.211194936472, 8313.584320783997, 8360.080391156967, 8449.915500844974, 41457.585424145975, 41863.37204941928, 41900.37149442761, 41925.79037104826, 42242.0, 3718.72109591779, 3772.9434058489146, 3773.6792372648356, 3779.4519794629623, 3783.1677031053123, 34094.0, 34147.14632134192, 34199.6580034199, 34240.48639270413, 34245.143871403416, 5435.347758269033, 5476.726163691799, 5489.451054894518, 5540.556755459554, 5589.860253493654, 204711.0, 205896.0, 218690.0, 219027.0, 219107.0, 53644.85420583133, 53839.730801345744, 53918.0, 55390.0, 55939.0, 55481.0, 55619.721901390236, 55829.44170558324, 55871.44128558744, 55894.0, 16443.83556164423, 16471.83528164703, 16567.834321656872, 16578.336866525206, 16580.917095414687, 13465.865341346656, 13515.0, 13515.526956556474, 13522.661933451545, 13523.66190845217, 15162.924185379003, 15225.390984360723, 15242.323344432103, 15277.847221527643, 15384.615384615474, 6196.225471816023, 6246.75012999484, 6290.2766181889665, 6291.276503202099, 6326.5255105867245, 1109.8834622364698, 1115.59838458155, 1117.3016864459712, 1123.0341905960868, 1127.9605213817476, 26219.606705899427, 26324.60513092305, 26336.473270534865, 26408.20775376742, 26445.33886652849, 1174.2895548193221, 1199.1066655341826, 1200.6098018143964, 1213.0, 1214.5384753793678, 13441.932790335986, 13450.058495905192, 13815.723685526435, 13997.860021399656, 14017.71964560703, 302346.0, 302864.0, 303214.0, 303952.0, 305194.0, 59454.702726486954, 59493.405065948784, 59707.40292597105, 59755.70122149361, 60047.69976150179, 1503.8345781964194, 1525.603343130794, 1541.884358673104, 1545.2737213509633, 1550.689862027599, 24904.37739056538, 24911.377215569755, 25080.247592572254, 25197.74802251954, 25290.36774080663, 40571.7971410141, 40624.1875162501, 40659.3901091478, 40677.796611016754, 40691.7965410171, 253097.0, 254594.0, 254841.0, 254859.0, 255342.0, 34154.48768268428, 34159.0, 36912.44631330478, 37278.44082338713, 37946.810265948494, 47523.0, 47527.287090692975, 47532.7623361881, 47606.52393476159, 47930.0, 33690.32619347648, 34573.13567160741, 34684.30631387408, 34752.826235868655, 35154.0, 34244.82877585596, 34336.31327373389, 34362.656373435944, 34364.26116838448, 34542.48186277158, 41237.1752564953, 41329.58670413258, 41486.17027659369, 41509.37735934024, 41675.16649667051, 33630.327393452484, 33632.3273534523, 33643.3271334567, 33980.0, 34218.65781342254, 25885.0, 25900.61149082803, 26124.73875261223, 26126.73873261243, 26544.070957516393], "value": 18789.337778140405, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [596.1370716510903, 606.4935778624848, 615.664462867737, 630.79814459373, 638.8051644248504, 23275.883620581895, 23443.765562344415, 23969.400764980885, 23995.880020599874, 24052.759472405272, 26078.348041298977, 27066.05268815592, 27193.0, 27227.727722722768, 27262.182134535997, 6418.807435776934, 6548.214214294268, 6549.57427767196, 6558.21301443825, 6559.442447391977, 6524.739010439576, 6746.257911629717, 6803.863922721543, 6809.625470599115, 6809.897851532231, 6696.8995465068065, 6713.060171575983, 6729.427998620124, 6731.293214212511, 6734.966325168367, 6683.766068187614, 6708.362705543014, 6712.429443497309, 6722.193336799591, 6746.8313292167595, 6256.374362563753, 6264.060390941349, 6296.811095667137, 6299.65351905645, 6328.430441260262, 27522.633251393825, 30794.69205307963, 31022.844885775652, 31533.896313628913, 31733.365332693447, 2254.729432468098, 2281.7604151564015, 2283.977160228393, 2285.5543169082034, 2291.942701432461, 20945.790542094535, 21202.469938251514, 21212.893935530377, 21247.36257912265, 21264.0, 2411.9517609647883, 2465.3097132802845, 2480.454300053985, 2502.0367158644053, 2510.1465501729317, 133450.0, 139552.30223848918, 151652.0, 160228.0, 165943.170284149, 16027.919860400623, 16927.730420218533, 16950.745738813926, 17008.57478563021, 17122.486325410257, 26189.869050655005, 26247.0, 26259.343516412242, 26273.0, 26321.07876224323, 10249.487525623837, 10337.586496540205, 10384.0, 10450.947745261377, 10608.098311643442, 9379.5310234488, 9392.530373481299, 9430.151286384258, 9476.857847132298, 9590.760230994141, 9737.756556086155, 10050.64822731201, 10140.847887281696, 10257.794844103077, 10357.533910974023, 2785.9442811143663, 2801.4257077299103, 2802.859857007182, 2803.7383177570173, 2805.8456784877026, 1018.2159737002466, 1048.0410424461684, 1053.478528128566, 1062.877769056553, 1066.6213494209599, 21699.45751356197, 21895.0, 22112.22607208772, 22318.21886233974, 22361.0, 1086.5708045322053, 1097.6926460591046, 1110.6723516562633, 1111.4276147783899, 1118.8937050980144, 12092.395380230953, 12359.567415140607, 12426.0, 12435.37823108859, 12472.126951113516, 662714.0, 663120.0, 674704.0, 682728.0, 703337.0, 127738.0, 131734.34132829466, 134379.32810335886, 134396.0, 134480.3275983614, 1204.7710934922336, 1209.176627221873, 1232.648695121904, 1235.2464996352219, 1238.8079847623633, 19763.40709778709, 19844.10701518464, 19902.800971990095, 20129.094190761745, 20166.0, 59140.40859591349, 60898.695506522185, 62091.068633969626, 62436.687816560625, 62928.685356572925, 82825.0, 83009.0, 83288.0, 83845.58077209575, 83897.0, 15725.528234152993, 15930.36278548845, 16160.595985099997, 16163.919180404022, 16203.594910127342, 24477.755222447548, 24758.752412475646, 24919.127830525846, 24935.625965610892, 25122.37194070163, 19574.314898978468, 19669.50826229356, 20118.698219526425, 20465.38603841887, 20520.486987825425, 17095.829041709425, 17137.571560710585, 17595.472135835946, 17989.19048642788, 18236.45290641283, 19921.302754403525, 20455.693164602246, 20541.178352865718, 20622.793772062687, 20859.0, 15601.765973510179, 15740.60648483797, 15767.211639418212, 15824.0, 15931.761023584888, 19597.0, 19732.50668733293, 19754.90122549378, 19764.0, 19923.10346034461], "value": 12938.825316229639, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1392.303848075962, 1470.5735336752343, 1488.360005197766, 1494.5516345096469, 1504.909705417675, 16671.749923751155, 17380.39168629097, 17413.912930435363, 17415.042172680496, 17428.0, 17114.400995965145, 17213.397531086383, 17224.56938576533, 17245.655086898256, 17254.2235599398, 2873.74136327731, 2893.5370340745485, 2928.4289563535117, 2928.780341474387, 2929.033418971745, 2788.9023884164058, 2816.239615303877, 2831.603575499432, 2845.544712845945, 2847.387811620501, 2801.4677211329886, 2883.09182607478, 2893.6961619030017, 2898.0291602313146, 2900.013995241628, 2821.6755073166437, 2823.4635419270376, 2851.7433430991105, 2857.185702074909, 2859.0850927703145, 2695.3935364543017, 2808.1154436352485, 2812.9437411251865, 2815.155453363983, 2823.0966090850934, 16941.83058169427, 17080.743788843178, 17090.31638734449, 17107.31570737169, 17111.14444277781, 7799.805004874924, 8085.555294458803, 8086.312663423557, 8087.393445491612, 8090.271875531231, 5403.486668766461, 5601.551875849922, 5658.688772117532, 5750.30996280449, 5754.625949313281, 2147.516808718026, 2171.6742488626674, 2177.7495588007423, 2182.7271591051117, 2204.9448763780874, 30448.84775576108, 30795.846020769975, 30803.383932321227, 30808.845955770303, 30838.0, 7092.858142837114, 7297.525660832135, 7312.926870731331, 7465.06686664167, 7476.813079673052, 17317.653646926992, 17807.0, 19652.803471965384, 19681.11434985429, 19689.11398987049, 8463.195996380335, 8654.524001179869, 8656.701494775834, 8727.650893964297, 8742.694005709769, 7846.568438735924, 7926.365890728844, 7981.1220765715725, 8036.799080023046, 8098.5545794981845, 5613.7193140342815, 5624.128260119606, 5752.798652047159, 5787.045137552257, 5821.650700957956, 1623.983760162407, 1650.1996531682125, 1664.9916750416412, 1667.1414221675846, 1690.4083570750386, 989.678354534779, 992.8808542974889, 993.5032483758121, 997.6258902911409, 1011.600417834951, 8650.562161892678, 8720.476771393609, 8730.65077396897, 8898.0, 8928.241099506486, 810.5136917849243, 811.2293321344746, 814.2712272516065, 816.8366326734676, 826.7519744076753, 5333.439988801198, 5423.972880135653, 6152.723127459275, 6270.498360131179, 6290.716917738713, 24730.876345618155, 24812.875935620566, 25145.622815657778, 25587.23238302854, 25787.742122578908, 24088.552054248037, 24893.377665558142, 25001.4999700005, 25025.874870625896, 25288.494230115295, 11562.537498500134, 11694.181407301407, 11787.764244715057, 11850.229735067365, 11909.583164589198, 9414.62341506332, 9465.858012129962, 9694.563744631367, 9696.175825054666, 9794.16749576294, 21000.054997524843, 21158.0, 21166.365009049754, 21375.25186618523, 21592.244271450425, 21502.462438439165, 21996.340109796733, 22150.446238844157, 22174.445638858513, 22218.555628887007, 12473.064520160842, 12531.624051278477, 12590.181638193488, 12602.0, 12617.053720971147, 15521.301541430437, 15646.843531564538, 15694.607634809221, 15770.68458630844, 15848.60378490547, 12564.0, 12915.870841291468, 13173.341332933507, 13177.73644527085, 13184.340782960622, 12290.262584244974, 12321.258460142004, 12384.690382740504, 12663.113582049167, 12808.231506109663, 10945.398003109905, 10988.615398461016, 11147.888521114684, 11160.944195278971, 11225.831612525655, 8086.393520485869, 8105.351571874354, 8229.629666664894, 8256.793580160544, 8267.83464330722, 7836.0, 7975.601219938864, 8008.919910800817, 8099.878501822595, 8105.918940810517], "value": 7307.924912068951, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [535.8660334916271, 556.0741365626233, 559.6753882748006, 572.9140628905664, 582.8251524542637, 6366.172397588312, 6380.840478988028, 6397.840053998652, 6418.454431373327, 6458.320836582488, 6257.655828929407, 6315.147455093561, 6321.810345689625, 6330.512329602551, 6381.680915954195, 5171.870703232412, 5190.221466779994, 5204.869878253036, 5205.427402985669, 5224.817131400402, 5166.922496162541, 5215.791368345262, 5219.530242278194, 5237.79048838046, 5244.475552444763, 4822.397200349957, 4930.137225985456, 5006.599472042228, 5040.621953353513, 5158.432572417031, 5001.274815151783, 5009.674371165863, 5019.222020586815, 5024.874378140576, 5037.49625037497, 4537.682362234645, 4557.703749256288, 4573.016801387685, 4579.496255411902, 4600.585947264729, 6115.510759139258, 6146.7541298348015, 6179.28938172107, 6190.752369905198, 6232.909240882873, 5863.2670916135485, 5875.559333049996, 5881.147233651097, 5936.1095835625, 5951.196588460546, 6660.9000864987065, 6665.366790154976, 6672.799816005528, 6696.459814242751, 6749.7300107995625, 5084.644074914758, 5084.932164245476, 5105.749091472613, 5106.795728170869, 5123.257127716498, 6721.899171512431, 6893.379595836349, 6939.340762627542, 6958.7912362628695, 6971.4771392145285, 5203.505666961632, 5216.947830521646, 5225.555827754683, 5253.605979551472, 5263.999840030382, 5263.6841789492755, 5278.709670968057, 5299.33758280215, 5301.8866038131655, 5301.893962120736, 5854.326752423526, 5866.7653293868625, 5874.765009399662, 5894.823155305347, 5897.52819774417, 6735.831604209836, 6744.42672372844, 6752.729890804313, 6787.5588086774205, 6805.863882722318, 1790.4628611416522, 1819.7179437187258, 1838.1728222300019, 1839.6136811269516, 1841.327915310902, 1238.7089034076985, 1287.3563218390805, 1287.3820566128124, 1294.0747365633617, 1303.0683061610994, 6184.196054512884, 6242.0, 6249.78125765596, 6283.151774510474, 6289.182406287154, 6645.867082658319, 6690.799276021728, 6839.076724642109, 6867.690953907087, 6915.0, 6079.848003799941, 6151.7539298428455, 6169.413905678954, 6209.602839361108, 6298.205011571772, 3551.6803487686234, 3561.982190089033, 3581.4448760442174, 3588.2105936693883, 3594.5327107476382, 6914.965425172943, 6935.3411425914455, 6991.335823096798, 7024.332688394595, 7034.296570343027, 6971.407430368374, 6997.370236678723, 7017.508774385846, 7018.473614478832, 7025.262347453444, 6822.624755638488, 6912.68191268184, 6950.965245173742, 6988.113209433424, 7015.3864611139725, 6745.831354216184, 6749.628770417674, 6751.324867513209, 6798.354156355138, 6855.0, 6649.867002660017, 6676.155517267289, 6690.531662783558, 6707.295733947865, 6750.86498270022, 6909.170899492093, 6931.480138989495, 6950.826229344307, 6955.582665040114, 6982.825429364307, 4999.475160076212, 5103.770330335218, 5121.8719532012, 5157.638965272395, 5177.611679124006, 6620.172478440195, 6811.557248778813, 6811.739828131812, 6812.420944219797, 6839.89740153908, 6332.30344662096, 6658.766943156967, 6671.799846004627, 6713.899291510534, 6726.730930762715, 6627.933720662924, 6670.866582668223, 6710.429613482908, 6716.3955244028275, 6717.227518835396, 6483.7730679425995, 6494.6227961458835, 6533.575317604341, 6539.901901471387, 6544.738210471528, 6629.270780214076, 6681.732730690718, 6695.296993815774, 6751.56114852533, 6756.966215168893, 6508.869822603616, 6551.148350714377, 6562.639054851838, 6565.704543295467, 6590.604563726191], "value": 5220.7083834961895, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [964.1419136968095, 966.6423423333367, 982.4645568165349, 988.2489308125827, 990.7325022243995, 22530.77469225307, 23492.0, 24860.0, 24870.50258994819, 25127.49745005099, 22909.4272643184, 23129.768702312973, 23859.28422147334, 23868.403289917762, 23959.161429349977, 1058.9417582033004, 1080.7730376620918, 1081.378207530669, 1081.464674985883, 1081.913446924248, 1070.5129166229385, 1088.1131877519836, 1088.9237753357268, 1091.0398849012859, 1100.6918062942389, 1127.8421021057018, 1130.9717257068598, 1131.9151063670217, 1132.0, 1132.30363326554, 1135.7444574970607, 1137.7269455330743, 1137.954481820722, 1138.1975707126496, 1138.618562781469, 836.021854430318, 837.3803385494751, 837.6691206973211, 837.7486753973783, 838.4927119092922, 18853.62292754151, 18978.90510547452, 18980.5254868628, 18982.62034759311, 19739.80260197394, 23228.88385558078, 23778.16776412817, 23846.52306953851, 23870.76129238703, 23879.0, 18221.0, 18263.0, 18353.63292734151, 18409.171587278604, 18415.72376414355, 3862.748921320105, 3924.097457584743, 3936.8622098226424, 3968.0873399118364, 3972.8410863565423, 157035.0, 160465.0, 161681.0, 161736.19131904384, 162721.0, 17666.734998975026, 17950.820491795177, 18016.819831801513, 18052.91682499054, 18141.274349026156, 34624.653753462146, 34713.479297810554, 34787.478187827204, 34854.30291394158, 34964.300713986086, 8596.656133754579, 8788.296936245086, 8829.64681412749, 8875.423097498642, 8886.555672216364, 4596.931046034312, 4624.514425985223, 4651.651126165551, 4659.767011649404, 4673.485916549177, 6082.2701275847185, 6204.937950620436, 6216.595921265103, 6235.594686345373, 6241.469475094577, 992.8560358748085, 1030.4796077980723, 1051.7791263834526, 1054.146141625286, 1055.134789472625, 693.4002088193677, 703.8416356319788, 705.2665228162756, 712.803978905805, 719.7301012120455, 11774.70478247392, 11948.441247002364, 12258.14193006481, 12738.490460381481, 13037.0, 704.6969802984663, 708.2032713197652, 718.0521711341084, 721.1094298541298, 726.3862036579083, 5915.615484993462, 5951.137085122633, 6035.818925432244, 6087.54343424245, 6096.146539484475, 148479.0, 154266.0, 154860.0, 157164.0, 158367.0, 133990.0, 134305.0, 135048.0, 135832.3208383952, 139514.0, 117757.0, 119376.4031179856, 119903.40048299702, 119925.0, 119942.0, 10833.67498975032, 10938.835917461403, 10967.725806854893, 11053.889461105286, 11297.774044519228, 55815.44184558102, 56035.43964560302, 57073.429265706814, 58303.4169658298, 58940.410595895206, 70237.0, 72167.27832721606, 72641.6367918157, 72661.0, 74480.62759686167, 16884.071376074433, 16984.150792460576, 17083.231254593822, 17180.828191717923, 17187.484375468757, 17611.53438518634, 17839.0, 18435.72346414778, 18528.351507697706, 18552.907235463736, 16158.192090395669, 16373.508794736177, 16401.753973690644, 16406.179691015164, 16460.506184814476, 15364.539063828102, 15579.922100389425, 15616.843831561539, 15631.218439078228, 15844.366225351318, 15662.76505852436, 15679.921600391925, 15736.842631573538, 15746.133962632166, 15863.286152122952, 12757.936210318889, 12861.871381286068, 12864.742705145658, 12943.288119153536, 13243.072984890965, 12652.114351995271, 12851.100422970303, 12933.611991640266, 12951.028672849763, 13000.479980800663], "value": 9833.153123019902, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1376.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 105.0, 107.0, 106.0, 106.0, 95.0, 107.0, 106.0, 106.0, 107.0], "value": 105.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 111.0, 111.0, 115.0, 113.0, 139.0, 114.0, 114.0, 121.0, 111.0], "value": 116.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 163.0, 163.0, 163.0, 163.0, 161.0, 165.0, 165.0, 170.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 72.0, 73.0, 73.0, 73.0, 73.0, 74.0, 76.0, 76.0, 77.0], "value": 74.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 78.0, 77.0, 76.0, 78.0, 78.0, 78.0, 78.0, 82.0], "value": 78.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 114.0, 113.0, 117.0, 113.0, 114.0, 114.0, 114.0, 114.0, 116.0], "value": 113.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 149.0, 151.0, 151.0, 150.0, 152.0, 151.0, 149.0, 149.0], "value": 150.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 94.0, 94.0, 93.0, 94.0, 93.0, 94.0, 94.0, 94.0], "value": 93.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [43.0, 44.0, 44.0, 44.0, 44.0, 44.0, 43.0, 43.0, 44.0, 44.0], "value": 43.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [39.0, 39.0, 39.0, 39.0, 42.0, 38.0, 38.0, 38.0, 39.0, 39.0], "value": 39.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 71.0, 74.0, 73.0, 82.0, 73.0, 75.0, 72.0, 73.0, 73.0], "value": 73.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 104.0, 104.0, 110.0, 109.0, 104.0, 105.0, 109.0, 110.0, 109.0], "value": 107.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 151.0, 165.0, 159.0, 152.0, 163.0, 157.0, 151.0, 156.0, 155.0], "value": 156.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 63.0, 60.0, 59.0, 60.0, 61.0, 65.0, 59.0, 59.0, 58.0], "value": 61.0, "unit": "score"}]}]} 16:26:09 INFO - Return code: 0 16:26:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:26:09 INFO - # TBPL SUCCESS # 16:26:09 INFO - Running post-action listener: _package_coverage_data 16:26:09 INFO - Running post-action listener: _resource_record_post_action 16:26:09 INFO - [mozharness: 2017-09-19 23:26:09.085256Z] Finished run-tests step (success) 16:26:09 INFO - Running post-run listener: _resource_record_post_run 16:26:09 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 9035776; Write bytes: 454397952; Read time: 3116; Write time: 385804 16:26:09 INFO - TinderboxPrint: CPU usage
13.1% 16:26:09 INFO - TinderboxPrint: I/O read bytes / time
9,035,776 / 3,116 16:26:09 INFO - TinderboxPrint: I/O write bytes / time
454,397,952 / 385,804 16:26:09 INFO - TinderboxPrint: CPU idle
8,219.9 (86.9%) 16:26:09 INFO - TinderboxPrint: CPU user
1,185.8 (12.5%) 16:26:09 INFO - TinderboxPrint: Swap in / out
0 / 0 16:26:09 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 8192; Write bytes: 143343616; Read time: 268; Write time: 178844 16:26:09 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 16:26:09 INFO - run-tests - Wall time: 1169s; CPU: 13.0%; Read bytes: 6787072; Write bytes: 311054336; Read time: 2636; Write time: 206960 16:26:09 INFO - Running post-run listener: _upload_blobber_files 16:26:09 INFO - Blob upload gear active. 16:26:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:26:09 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 16:26:09 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'] 16:26:09 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 16:26:10 INFO - (blobuploader) - INFO - Open directory for files ... 16:26:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 16:26:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:26:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:26:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 16:26:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:26:11 INFO - (blobuploader) - INFO - Done attempting. 16:26:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:26:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:26:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:26:12 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:26:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:26:12 INFO - (blobuploader) - INFO - Done attempting. 16:26:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 16:26:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:26:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:26:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 16:26:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:26:13 INFO - (blobuploader) - INFO - Done attempting. 16:26:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:26:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:26:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:26:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:26:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:26:19 INFO - (blobuploader) - INFO - Done attempting. 16:26:19 INFO - (blobuploader) - INFO - Iteration through files over. 16:26:19 INFO - Return code: 0 16:26:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:26:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:26:19 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3a88f703aba54ddf64f3333fd4115ebf8bb7d989f85402a8a737a0023ded7bcbd9f317059de77a9b4ef1cff9bcfcf96e6c2db2c88cc0497aef0e890b804706af", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c6614d7cd4247c0d004bf0237746cfc06d9a6855488f2e1bb79eb9ef71da1521476797f137c2d06eb6e5515fa7aad5329cd4317788909150deef90383bd015e4", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac78bd2b1dddbb153ccfaf19981242bd1f8b981f34df4a720560d97380e9655ef71f0f1ae47e93db1b2f37e8fd701078185fbf974d7684c4d76127d08b96d641", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ede90befaf7e8117f3a16240e37eebf1fa38b3d1f4ac3791171bc7f168443b9f8c65af972ef3bef4ec88b6519025295923c9eedd36a063a027bc56a1ad798ed6"} 16:26:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:26:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:26:19 INFO - Contents: 16:26:19 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3a88f703aba54ddf64f3333fd4115ebf8bb7d989f85402a8a737a0023ded7bcbd9f317059de77a9b4ef1cff9bcfcf96e6c2db2c88cc0497aef0e890b804706af", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c6614d7cd4247c0d004bf0237746cfc06d9a6855488f2e1bb79eb9ef71da1521476797f137c2d06eb6e5515fa7aad5329cd4317788909150deef90383bd015e4", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac78bd2b1dddbb153ccfaf19981242bd1f8b981f34df4a720560d97380e9655ef71f0f1ae47e93db1b2f37e8fd701078185fbf974d7684c4d76127d08b96d641", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ede90befaf7e8117f3a16240e37eebf1fa38b3d1f4ac3791171bc7f168443b9f8c65af972ef3bef4ec88b6519025295923c9eedd36a063a027bc56a1ad798ed6"} 16:26:19 INFO - Running post-run listener: copy_logs_to_upload_dir 16:26:19 INFO - Copying logs to upload dir... 16:26:19 INFO - mkdir: /builds/slave/test/build/upload/logs 16:26:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.889815 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2017-09-19 16:26:20.045370) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-19 16:26:20.051779) ========= 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=6d15e502d8e29d5d2676d664000001c3-1505860996.552136-1997593267 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/3a88f703aba54ddf64f3333fd4115ebf8bb7d989f85402a8a737a0023ded7bcbd9f317059de77a9b4ef1cff9bcfcf96e6c2db2c88cc0497aef0e890b804706af", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c6614d7cd4247c0d004bf0237746cfc06d9a6855488f2e1bb79eb9ef71da1521476797f137c2d06eb6e5515fa7aad5329cd4317788909150deef90383bd015e4", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac78bd2b1dddbb153ccfaf19981242bd1f8b981f34df4a720560d97380e9655ef71f0f1ae47e93db1b2f37e8fd701078185fbf974d7684c4d76127d08b96d641", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ede90befaf7e8117f3a16240e37eebf1fa38b3d1f4ac3791171bc7f168443b9f8c65af972ef3bef4ec88b6519025295923c9eedd36a063a027bc56a1ad798ed6"} build_url:https://queue.taskcluster.net/v1/task/Y7gb7BDOTseBUm1jZrOsyg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011595 build_url: 'https://queue.taskcluster.net/v1/task/Y7gb7BDOTseBUm1jZrOsyg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3a88f703aba54ddf64f3333fd4115ebf8bb7d989f85402a8a737a0023ded7bcbd9f317059de77a9b4ef1cff9bcfcf96e6c2db2c88cc0497aef0e890b804706af", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c6614d7cd4247c0d004bf0237746cfc06d9a6855488f2e1bb79eb9ef71da1521476797f137c2d06eb6e5515fa7aad5329cd4317788909150deef90383bd015e4", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac78bd2b1dddbb153ccfaf19981242bd1f8b981f34df4a720560d97380e9655ef71f0f1ae47e93db1b2f37e8fd701078185fbf974d7684c4d76127d08b96d641", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ede90befaf7e8117f3a16240e37eebf1fa38b3d1f4ac3791171bc7f168443b9f8c65af972ef3bef4ec88b6519025295923c9eedd36a063a027bc56a1ad798ed6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-19 16:26:20.080102) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 16:26:20.082414) ========= 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=6d15e502d8e29d5d2676d664000001c3-1505860996.552136-1997593267 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004726 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 16:26:20.135975) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-19 16:26:20.136283) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-19 16:26:20.136616) ========= ========= Total master_lag: 0.30 =========