builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s-pgo slave: talos-linux64-ix-073 starttime: 1507029149.66 results: success (0) revision: 11fe0a2895aab26c57bcfe61b3041d7837e954cd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-10-03 04:12:29.657546) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-10-03 04:12:29.658548) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-03 04:12:29.658835) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-03 04:12:29.693571) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-03 04:12:29.693844) ========= 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=9531f05ccb2eabcb9acf5f1b000001c0-1507029044.924251-868986532 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-10-03 04:12:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 230M=0s 2017-10-03 04:12:29 (230 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.150167 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-03 04:12:29.861141) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-03 04:12:29.861495) ========= 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=9531f05ccb2eabcb9acf5f1b000001c0-1507029044.924251-868986532 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019331 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-03 04:12:29.911523) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-03 04:12:29.911882) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 11fe0a2895aab26c57bcfe61b3041d7837e954cd --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 11fe0a2895aab26c57bcfe61b3041d7837e954cd --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=9531f05ccb2eabcb9acf5f1b000001c0-1507029044.924251-868986532 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-10-03 04:12:29,960 truncating revision to first 12 chars 2017-10-03 04:12:29,960 Setting DEBUG logging. 2017-10-03 04:12:29,960 attempt 1/10 2017-10-03 04:12:29,960 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/11fe0a2895aa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-10-03 04:12:30,415 unpacking tar archive at: mozilla-central-11fe0a2895aa/testing/mozharness/ program finished with exit code 0 elapsedTime=0.738052 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-03 04:12:30.667128) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-03 04:12:30.667414) ========= script_repo_revision: 11fe0a2895aab26c57bcfe61b3041d7837e954cd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-03 04:12:30.667764) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-03 04:12:30.668035) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-03 04:12:30.683824) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2017-10-03 04:12:30.684080) ========= /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=9531f05ccb2eabcb9acf5f1b000001c0-1507029044.924251-868986532 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:12:30 INFO - MultiFileLogger online at 20171003 04:12:30 in /builds/slave/test 04:12:30 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 04:12:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:12:30 INFO - {'append_to_log': False, 04:12:30 INFO - 'base_work_dir': '/builds/slave/test', 04:12:30 INFO - 'blob_upload_branch': 'Firefox', 04:12:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:12:30 INFO - 'branch': 'Firefox', 04:12:30 INFO - 'buildbot_json_path': 'buildprops.json', 04:12:30 INFO - 'code_coverage': False, 04:12:30 INFO - 'config_files': ('talos/linux_config.py',), 04:12:30 INFO - 'default_actions': ('clobber', 04:12:30 INFO - 'read-buildbot-config', 04:12:30 INFO - 'download-and-extract', 04:12:30 INFO - 'populate-webroot', 04:12:30 INFO - 'create-virtualenv', 04:12:30 INFO - 'install', 04:12:30 INFO - 'setup-mitmproxy', 04:12:30 INFO - 'run-tests'), 04:12:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:12:30 INFO - 'disable_ccov_upload': False, 04:12:30 INFO - 'disable_stylo': False, 04:12:30 INFO - 'download_minidump_stackwalk': True, 04:12:30 INFO - 'download_symbols': 'ondemand', 04:12:30 INFO - 'enable_stylo': False, 04:12:30 INFO - 'enable_webrender': False, 04:12:30 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 04:12:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:12:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:12:30 INFO - 'gecko_profile': False, 04:12:30 INFO - 'gecko_profile_interval': 0, 04:12:30 INFO - 'installer_path': 'installer.exe', 04:12:30 INFO - 'log_level': 'info', 04:12:30 INFO - 'log_name': 'talos', 04:12:30 INFO - 'log_to_console': True, 04:12:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:12:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:12:30 INFO - 'opt_config_files': (), 04:12:30 INFO - 'pip_index': False, 04:12:30 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 04:12:30 INFO - 'system_bits': '32', 04:12:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:12:30 INFO - 'title': 'talos-linux64-ix-073', 04:12:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:12:30 INFO - 'use_talos_json': True, 04:12:30 INFO - 'verify': 'False', 04:12:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:12:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:12:30 INFO - 'work_dir': 'build'} 04:12:30 INFO - [mozharness: 2017-10-03 11:12:30.876925Z] Running clobber step. 04:12:30 INFO - Running pre-action listener: _resource_record_pre_action 04:12:30 INFO - Running main action method: clobber 04:12:30 INFO - rmtree: /builds/slave/test/build 04:12:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:12:32 INFO - Running post-action listener: _resource_record_post_action 04:12:32 INFO - [mozharness: 2017-10-03 11:12:32.371947Z] Finished clobber step (success) 04:12:32 INFO - [mozharness: 2017-10-03 11:12:32.372045Z] Running read-buildbot-config step. 04:12:32 INFO - Running pre-action listener: _resource_record_pre_action 04:12:32 INFO - Running main action method: read_buildbot_config 04:12:32 INFO - Using buildbot properties: 04:12:32 INFO - { 04:12:32 INFO - "project": "", 04:12:32 INFO - "product": "firefox", 04:12:32 INFO - "who": "archaeopteryx@coole-files.de", 04:12:32 INFO - "installer_path": "public/build/target.tar.bz2", 04:12:32 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 04:12:32 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 04:12:32 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-stylo-disabled-e10s", 04:12:32 INFO - "stage_platform": "linux64-pgo", 04:12:32 INFO - "basedir": "/builds/slave/test", 04:12:32 INFO - "buildnumber": 10, 04:12:32 INFO - "platform": "ubuntu64_hw", 04:12:32 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:12:32 INFO - "slavebuilddir": "test", 04:12:32 INFO - "taskId": "HpuOUml4RWmrbQiKEluNVQ", 04:12:32 INFO - "branch": "mozilla-central", 04:12:32 INFO - "script_repo_revision": "production", 04:12:32 INFO - "revision": "11fe0a2895aab26c57bcfe61b3041d7837e954cd", 04:12:32 INFO - "slavename": "talos-linux64-ix-073", 04:12:32 INFO - "repo_path": "mozilla-central" 04:12:32 INFO - } 04:12:32 INFO - Finding installer, test and symbols from parent task. 04:12:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HpuOUml4RWmrbQiKEluNVQ'}, attempt #1 04:12:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HpuOUml4RWmrbQiKEluNVQ'}, attempt #1 04:12:33 INFO - Task dependencies: HK3Cnu3ZQ2u3dGHBaXWQPg 04:12:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HK3Cnu3ZQ2u3dGHBaXWQPg'}, attempt #1 04:12:33 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/HK3Cnu3ZQ2u3dGHBaXWQPg/artifacts/public/build/target.tar.bz2 04:12:33 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/HK3Cnu3ZQ2u3dGHBaXWQPg/artifacts/public/build/target.test_packages.json 04:12:33 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/HK3Cnu3ZQ2u3dGHBaXWQPg/artifacts/public/build/target.crashreporter-symbols.zip 04:12:33 INFO - Running post-action listener: _resource_record_post_action 04:12:33 INFO - [mozharness: 2017-10-03 11:12:33.834261Z] Finished read-buildbot-config step (success) 04:12:33 INFO - [mozharness: 2017-10-03 11:12:33.834479Z] Running download-and-extract step. 04:12:33 INFO - Running pre-action listener: _resource_record_pre_action 04:12:33 INFO - Running main action method: download_and_extract 04:12:33 INFO - mkdir: /builds/slave/test/build/tests 04:12:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:33 INFO - trying https://queue.taskcluster.net/v1/task/HK3Cnu3ZQ2u3dGHBaXWQPg/artifacts/public/build/target.test_packages.json 04:12:33 INFO - Downloading https://queue.taskcluster.net/v1/task/HK3Cnu3ZQ2u3dGHBaXWQPg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 04:12:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HK3Cnu3ZQ2u3dGHBaXWQPg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 04:12:34 INFO - Downloaded 989 bytes. 04:12:34 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 04:12:34 INFO - Using the following test package requirements: 04:12:34 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 04:12:34 INFO - u'common': [u'target.common.tests.zip'], 04:12:34 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 04:12:34 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 04:12:34 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 04:12:34 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 04:12:34 INFO - u'mozbase': [u'target.common.tests.zip'], 04:12:34 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 04:12:34 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 04:12:34 INFO - u'web-platform': [u'target.common.tests.zip', 04:12:34 INFO - u'target.web-platform.tests.tar.gz'], 04:12:34 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 04:12:34 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 04:12:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HK3Cnu3ZQ2u3dGHBaXWQPg/artifacts/public/build/target.common.tests.zip 04:12:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HK3Cnu3ZQ2u3dGHBaXWQPg/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:12:34 INFO - Fetch https://queue.taskcluster.net/v1/task/HK3Cnu3ZQ2u3dGHBaXWQPg/artifacts/public/build/target.common.tests.zip into memory 04:12:35 INFO - Content-Length response header: 55875174 04:12:35 INFO - Bytes received: 55875174 04:12:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HK3Cnu3ZQ2u3dGHBaXWQPg/artifacts/public/build/target.talos.tests.zip 04:12:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HK3Cnu3ZQ2u3dGHBaXWQPg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 04:12:46 INFO - Fetch https://queue.taskcluster.net/v1/task/HK3Cnu3ZQ2u3dGHBaXWQPg/artifacts/public/build/target.talos.tests.zip into memory 04:12:47 INFO - Content-Length response header: 14522427 04:12:47 INFO - Bytes received: 14522427 04:12:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:47 INFO - trying https://queue.taskcluster.net/v1/task/HK3Cnu3ZQ2u3dGHBaXWQPg/artifacts/public/build/target.tar.bz2 04:12:47 INFO - Downloading https://queue.taskcluster.net/v1/task/HK3Cnu3ZQ2u3dGHBaXWQPg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 04:12:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HK3Cnu3ZQ2u3dGHBaXWQPg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 04:12:48 INFO - Downloaded 62287392 bytes. 04:12:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HK3Cnu3ZQ2u3dGHBaXWQPg/artifacts/public/build/target.tar.bz2 04:12:48 INFO - mkdir: /builds/slave/test/properties 04:12:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:12:48 INFO - Writing to file /builds/slave/test/properties/build_url 04:12:48 INFO - Contents: 04:12:48 INFO - build_url:https://queue.taskcluster.net/v1/task/HK3Cnu3ZQ2u3dGHBaXWQPg/artifacts/public/build/target.tar.bz2 04:12:48 INFO - Running post-action listener: _resource_record_post_action 04:12:48 INFO - Running post-action listener: find_tests_for_verification 04:12:48 INFO - Running post-action listener: set_extra_try_arguments 04:12:48 INFO - [mozharness: 2017-10-03 11:12:48.775432Z] Finished download-and-extract step (success) 04:12:48 INFO - [mozharness: 2017-10-03 11:12:48.775532Z] Running populate-webroot step. 04:12:48 INFO - Running pre-action listener: _resource_record_pre_action 04:12:48 INFO - Running main action method: populate_webroot 04:12:48 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:12:48 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:12:48 INFO - 'tests': ['tresize', 04:12:48 INFO - 'tcanvasmark']}, 04:12:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:12:48 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:12:48 INFO - 'tests': ['dromaeo_css', 04:12:48 INFO - 'kraken']}, 04:12:48 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:12:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:12:48 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:12:48 INFO - 'talos_options': ['--disable-stylo'], 04:12:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:12:48 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:12:48 INFO - 'tests': ['damp', 'tps']}, 04:12:48 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:12:48 INFO - 'talos_options': ['--disable-stylo'], 04:12:48 INFO - 'tests': ['damp', 'tps']}, 04:12:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:12:48 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:12:48 INFO - 'tests': ['dromaeo_dom']}, 04:12:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 04:12:48 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:12:48 INFO - 'tests': ['basic_compositor_video', 04:12:48 INFO - 'glvideo']}, 04:12:48 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 04:12:48 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 04:12:48 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:12:48 INFO - 'talos_options': ['--disable-stylo'], 04:12:48 INFO - 'tests': ['ts_paint_webext', 04:12:48 INFO - 'tp5o_webext']}, 04:12:48 INFO - 'other-e10s': {'tests': ['a11yr', 04:12:48 INFO - 'ts_paint', 04:12:48 INFO - 'tpaint', 04:12:48 INFO - 'sessionrestore', 04:12:48 INFO - 'sessionrestore_many_windows', 04:12:48 INFO - 'sessionrestore_no_auto_restore', 04:12:48 INFO - 'tabpaint', 04:12:48 INFO - 'cpstartup']}, 04:12:48 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:12:48 INFO - 'tests': ['a11yr', 04:12:48 INFO - 'ts_paint', 04:12:48 INFO - 'tpaint', 04:12:48 INFO - 'sessionrestore', 04:12:48 INFO - 'sessionrestore_many_windows', 04:12:48 INFO - 'sessionrestore_no_auto_restore', 04:12:48 INFO - 'tabpaint', 04:12:48 INFO - 'cpstartup']}, 04:12:48 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 04:12:48 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 04:12:48 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:12:48 INFO - 'tests': ['perf_reftest_singletons']}, 04:12:48 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:12:48 INFO - 'tests': ['perf_reftest']}, 04:12:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:12:48 INFO - 'tsvgr_opacity', 04:12:48 INFO - 'tart', 04:12:48 INFO - 'tscrollx', 04:12:48 INFO - 'tsvg_static']}, 04:12:48 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:12:48 INFO - 'tests': ['tsvgx', 04:12:48 INFO - 'tsvgr_opacity', 04:12:48 INFO - 'tart', 04:12:48 INFO - 'tscrollx', 04:12:48 INFO - 'tsvg_static']}, 04:12:48 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:12:48 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:12:48 INFO - 'talos_options': ['--disable-stylo'], 04:12:48 INFO - 'tests': ['tp5o']}, 04:12:48 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:12:48 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 04:12:48 INFO - 'talos_options': ['--mitmproxy', 04:12:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:12:48 INFO - '--firstNonBlankPaint'], 04:12:48 INFO - 'tests': ['tp6_google', 04:12:48 INFO - 'tp6_youtube', 04:12:48 INFO - 'tp6_amazon', 04:12:48 INFO - 'tp6_facebook']}, 04:12:48 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:12:48 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 04:12:48 INFO - 'talos_options': ['--disable-stylo', 04:12:48 INFO - '--mitmproxy', 04:12:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:12:48 INFO - '--firstNonBlankPaint'], 04:12:48 INFO - 'tests': ['tp6_google', 04:12:48 INFO - 'tp6_youtube', 04:12:48 INFO - 'tp6_amazon', 04:12:48 INFO - 'tp6_facebook']}, 04:12:48 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:12:48 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 04:12:48 INFO - 'talos_options': ['--stylo-threads=1', 04:12:48 INFO - '--mitmproxy', 04:12:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:12:48 INFO - '--firstNonBlankPaint'], 04:12:48 INFO - 'tests': ['tp6_google', 04:12:48 INFO - 'tp6_youtube', 04:12:48 INFO - 'tp6_amazon', 04:12:48 INFO - 'tp6_facebook']}, 04:12:48 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:12:48 INFO - 'talos_options': ['--xperf_path', 04:12:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:12:48 INFO - 'tests': ['tp5n']}, 04:12:48 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:12:48 INFO - 'talos_options': ['--disable-stylo', 04:12:48 INFO - '--xperf_path', 04:12:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:12:48 INFO - 'tests': ['tp5n']}}} 04:12:48 INFO - Running post-action listener: _resource_record_post_action 04:12:48 INFO - [mozharness: 2017-10-03 11:12:48.796665Z] Finished populate-webroot step (success) 04:12:48 INFO - [mozharness: 2017-10-03 11:12:48.796754Z] Running create-virtualenv step. 04:12:48 INFO - Running pre-action listener: _resource_record_pre_action 04:12:48 INFO - Running main action method: create_virtualenv 04:12:48 INFO - Creating virtualenv /builds/slave/test/build/venv 04:12:48 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:12:48 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 04:12:48 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 04:12:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:12:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:12:49 INFO - Installing distribute.............................................................................................................................................................................................done. 04:12:49 INFO - Installing pip...............done. 04:12:49 INFO - Return code: 0 04:12:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:12:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:12:49 INFO - Reading from file tmpfile_stdout 04:12:49 INFO - Output received: 04:12:49 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 04:12:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:12:49 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')]} 04:12:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:49 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')]} 04:12:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:49 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 0xd2a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef2b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10979c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1094d60>, '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 0x1095a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1095ef0>, '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': '9531f05ccb2eabcb9acf5f1b000001c0-1507029044.924251-868986532', '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 04:12:49 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 04:12:49 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 04:12:49 INFO - Using env: {'DISPLAY': ':0', 04:12:49 INFO - 'HOME': '/home/cltbld', 04:12:49 INFO - 'LANG': 'en_US.UTF-8', 04:12:49 INFO - 'LANGUAGE': 'en_US:en', 04:12:49 INFO - 'LOGNAME': 'cltbld', 04:12:49 INFO - 'MAIL': '/var/mail/cltbld', 04:12:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:49 INFO - 'MOZ_NO_REMOTE': '1', 04:12:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:12:49 INFO - 'NO_EM_RESTART': '1', 04:12:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:12:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:49 INFO - 'PWD': '/builds/slave/test', 04:12:49 INFO - 'SHELL': '/bin/bash', 04:12:49 INFO - 'SHLVL': '1', 04:12:49 INFO - 'TERM': 'linux', 04:12:49 INFO - 'TMOUT': '86400', 04:12:49 INFO - 'USER': 'cltbld', 04:12:49 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1507029044.924251-868986532', 04:12:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:49 INFO - '_': '/tools/buildbot/bin/python'} 04:12:50 INFO - Ignoring indexes: http://pypi.python.org/simple/ 04:12:50 INFO - Downloading/unpacking pip>=1.5 04:12:50 INFO - Running setup.py egg_info for package pip 04:12:50 INFO - warning: no files found matching 'pip/cacert.pem' 04:12:50 INFO - warning: no files found matching '*.html' under directory 'docs' 04:12:50 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 04:12:50 INFO - no previously-included directories found matching 'docs/_build/_sources' 04:12:50 INFO - Installing collected packages: pip 04:12:50 INFO - Found existing installation: pip 1.1 04:12:50 INFO - Uninstalling pip: 04:12:50 INFO - Successfully uninstalled pip 04:12:50 INFO - Running setup.py install for pip 04:12:50 INFO - warning: no files found matching 'pip/cacert.pem' 04:12:50 INFO - warning: no files found matching '*.html' under directory 'docs' 04:12:50 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 04:12:50 INFO - no previously-included directories found matching 'docs/_build/_sources' 04:12:50 INFO - Installing pip script to /builds/slave/test/build/venv/bin 04:12:50 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 04:12:50 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 04:12:50 INFO - Successfully installed pip 04:12:50 INFO - Cleaning up... 04:12:50 INFO - Return code: 0 04:12:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:12:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xd2a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef2b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10979c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1094d60>, '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 0x1095a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1095ef0>, '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': '9531f05ccb2eabcb9acf5f1b000001c0-1507029044.924251-868986532', '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 04:12:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:12:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:12:50 INFO - Using env: {'DISPLAY': ':0', 04:12:50 INFO - 'HOME': '/home/cltbld', 04:12:50 INFO - 'LANG': 'en_US.UTF-8', 04:12:50 INFO - 'LANGUAGE': 'en_US:en', 04:12:50 INFO - 'LOGNAME': 'cltbld', 04:12:50 INFO - 'MAIL': '/var/mail/cltbld', 04:12:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:50 INFO - 'MOZ_NO_REMOTE': '1', 04:12:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:12:50 INFO - 'NO_EM_RESTART': '1', 04:12:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:12:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:51 INFO - 'PWD': '/builds/slave/test', 04:12:51 INFO - 'SHELL': '/bin/bash', 04:12:51 INFO - 'SHLVL': '1', 04:12:51 INFO - 'TERM': 'linux', 04:12:51 INFO - 'TMOUT': '86400', 04:12:51 INFO - 'USER': 'cltbld', 04:12:51 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1507029044.924251-868986532', 04:12:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:51 INFO - '_': '/tools/buildbot/bin/python'} 04:12:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:51 INFO - Downloading/unpacking psutil>=3.1.1 04:12:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:12:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:12:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:12:52 INFO - Installing collected packages: psutil 04:12:52 INFO - Running setup.py install for psutil 04:12:52 INFO - building 'psutil._psutil_linux' extension 04:12:52 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 04:12:52 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 04:12:52 INFO - building 'psutil._psutil_posix' extension 04:12:52 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 04:12:52 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 04:12:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:12:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:12:52 INFO - Successfully installed psutil 04:12:52 INFO - Cleaning up... 04:12:52 INFO - Return code: 0 04:12:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:12:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd2a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef2b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10979c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1094d60>, '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 0x1095a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1095ef0>, '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': '9531f05ccb2eabcb9acf5f1b000001c0-1507029044.924251-868986532', '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 04:12:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:12:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:12:52 INFO - Using env: {'DISPLAY': ':0', 04:12:52 INFO - 'HOME': '/home/cltbld', 04:12:52 INFO - 'LANG': 'en_US.UTF-8', 04:12:52 INFO - 'LANGUAGE': 'en_US:en', 04:12:52 INFO - 'LOGNAME': 'cltbld', 04:12:52 INFO - 'MAIL': '/var/mail/cltbld', 04:12:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:52 INFO - 'MOZ_NO_REMOTE': '1', 04:12:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:12:52 INFO - 'NO_EM_RESTART': '1', 04:12:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:12:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:52 INFO - 'PWD': '/builds/slave/test', 04:12:52 INFO - 'SHELL': '/bin/bash', 04:12:52 INFO - 'SHLVL': '1', 04:12:52 INFO - 'TERM': 'linux', 04:12:52 INFO - 'TMOUT': '86400', 04:12:52 INFO - 'USER': 'cltbld', 04:12:52 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1507029044.924251-868986532', 04:12:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:52 INFO - '_': '/tools/buildbot/bin/python'} 04:12:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:12:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:12:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:12:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:12:54 INFO - Installing collected packages: mozsystemmonitor 04:12:54 INFO - Running setup.py install for mozsystemmonitor 04:12:54 INFO - Successfully installed mozsystemmonitor 04:12:54 INFO - Cleaning up... 04:12:55 INFO - Return code: 0 04:12:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:12:55 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')]} 04:12:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:55 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')]} 04:12:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:55 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 0xd2a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef2b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10979c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1094d60>, '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 0x1095a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1095ef0>, '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': '9531f05ccb2eabcb9acf5f1b000001c0-1507029044.924251-868986532', '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 04:12:55 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 04:12:55 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 04:12:55 INFO - Using env: {'DISPLAY': ':0', 04:12:55 INFO - 'HOME': '/home/cltbld', 04:12:55 INFO - 'LANG': 'en_US.UTF-8', 04:12:55 INFO - 'LANGUAGE': 'en_US:en', 04:12:55 INFO - 'LOGNAME': 'cltbld', 04:12:55 INFO - 'MAIL': '/var/mail/cltbld', 04:12:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:55 INFO - 'MOZ_NO_REMOTE': '1', 04:12:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:12:55 INFO - 'NO_EM_RESTART': '1', 04:12:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:12:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:55 INFO - 'PWD': '/builds/slave/test', 04:12:55 INFO - 'SHELL': '/bin/bash', 04:12:55 INFO - 'SHLVL': '1', 04:12:55 INFO - 'TERM': 'linux', 04:12:55 INFO - 'TMOUT': '86400', 04:12:55 INFO - 'USER': 'cltbld', 04:12:55 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1507029044.924251-868986532', 04:12:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:55 INFO - '_': '/tools/buildbot/bin/python'} 04:12:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:55 INFO - Downloading/unpacking jsonschema==2.5.1 04:12:56 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 04:12:56 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 04:12:56 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 04:12:56 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 04:12:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:12:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:12:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:57 INFO - Downloading functools32-3.2.3-2.tar.gz 04:12:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:12:57 INFO - warning: no files found matching '*.txt' 04:12:57 INFO - no previously-included directories found matching 'build' 04:12:57 INFO - no previously-included directories found matching 'dist' 04:12:57 INFO - no previously-included directories found matching '.git*' 04:12:57 INFO - Installing collected packages: jsonschema, functools32 04:12:57 INFO - Running setup.py install for functools32 04:12:57 INFO - warning: no files found matching '*.txt' 04:12:57 INFO - no previously-included directories found matching 'build' 04:12:57 INFO - no previously-included directories found matching 'dist' 04:12:57 INFO - no previously-included directories found matching '.git*' 04:12:57 INFO - Successfully installed jsonschema functools32 04:12:57 INFO - Cleaning up... 04:12:57 INFO - Return code: 0 04:12:57 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:12: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')]} 04:12:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12: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')]} 04:12:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:57 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 0xd2a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef2b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10979c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1094d60>, '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 0x1095a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1095ef0>, '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': '9531f05ccb2eabcb9acf5f1b000001c0-1507029044.924251-868986532', '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 04:12:57 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 04:12:57 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 04:12:57 INFO - Using env: {'DISPLAY': ':0', 04:12:57 INFO - 'HOME': '/home/cltbld', 04:12:57 INFO - 'LANG': 'en_US.UTF-8', 04:12:57 INFO - 'LANGUAGE': 'en_US:en', 04:12:57 INFO - 'LOGNAME': 'cltbld', 04:12:57 INFO - 'MAIL': '/var/mail/cltbld', 04:12:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:57 INFO - 'MOZ_NO_REMOTE': '1', 04:12:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:12:57 INFO - 'NO_EM_RESTART': '1', 04:12:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:12:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:57 INFO - 'PWD': '/builds/slave/test', 04:12:57 INFO - 'SHELL': '/bin/bash', 04:12:57 INFO - 'SHLVL': '1', 04:12:57 INFO - 'TERM': 'linux', 04:12:57 INFO - 'TMOUT': '86400', 04:12:57 INFO - 'USER': 'cltbld', 04:12:57 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1507029044.924251-868986532', 04:12:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:57 INFO - '_': '/tools/buildbot/bin/python'} 04:12:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:58 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:12:58 INFO - Cleaning up... 04:12:58 INFO - Return code: 0 04:12:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:12:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:58 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 0xd2a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef2b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10979c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1094d60>, '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 0x1095a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1095ef0>, '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': '9531f05ccb2eabcb9acf5f1b000001c0-1507029044.924251-868986532', '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 04:12:58 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 04:12:58 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 04:12:58 INFO - Using env: {'DISPLAY': ':0', 04:12:58 INFO - 'HOME': '/home/cltbld', 04:12:58 INFO - 'LANG': 'en_US.UTF-8', 04:12:58 INFO - 'LANGUAGE': 'en_US:en', 04:12:58 INFO - 'LOGNAME': 'cltbld', 04:12:58 INFO - 'MAIL': '/var/mail/cltbld', 04:12:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:58 INFO - 'MOZ_NO_REMOTE': '1', 04:12:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:12:58 INFO - 'NO_EM_RESTART': '1', 04:12:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:12:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:58 INFO - 'PWD': '/builds/slave/test', 04:12:58 INFO - 'SHELL': '/bin/bash', 04:12:58 INFO - 'SHLVL': '1', 04:12:58 INFO - 'TERM': 'linux', 04:12:58 INFO - 'TMOUT': '86400', 04:12:58 INFO - 'USER': 'cltbld', 04:12:58 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1507029044.924251-868986532', 04:12:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:58 INFO - '_': '/tools/buildbot/bin/python'} 04:12:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:58 INFO - Downloading/unpacking blobuploader==1.2.4 04:12:58 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 04:12:58 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 04:12:58 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 04:12:58 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 04:12:59 INFO - Downloading blobuploader-1.2.4.tar.gz 04:12:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:12:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:12:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:12:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:12:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:59 INFO - Downloading docopt-0.6.1.tar.gz 04:12:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:13:00 INFO - Installing collected packages: blobuploader, requests, docopt 04:13:00 INFO - Running setup.py install for blobuploader 04:13:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:13:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:13:00 INFO - Running setup.py install for requests 04:13:00 INFO - Running setup.py install for docopt 04:13:00 INFO - Successfully installed blobuploader requests docopt 04:13:00 INFO - Cleaning up... 04:13:00 INFO - Return code: 0 04:13:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:13: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')]} 04:13:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13: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')]} 04:13:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:00 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 0xd2a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef2b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10979c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1094d60>, '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 0x1095a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1095ef0>, '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': '9531f05ccb2eabcb9acf5f1b000001c0-1507029044.924251-868986532', '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 04:13:00 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 04:13:00 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 04:13:00 INFO - Using env: {'DISPLAY': ':0', 04:13:00 INFO - 'HOME': '/home/cltbld', 04:13:00 INFO - 'LANG': 'en_US.UTF-8', 04:13:00 INFO - 'LANGUAGE': 'en_US:en', 04:13:00 INFO - 'LOGNAME': 'cltbld', 04:13:00 INFO - 'MAIL': '/var/mail/cltbld', 04:13:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:00 INFO - 'MOZ_NO_REMOTE': '1', 04:13:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:00 INFO - 'NO_EM_RESTART': '1', 04:13:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:00 INFO - 'PWD': '/builds/slave/test', 04:13:00 INFO - 'SHELL': '/bin/bash', 04:13:00 INFO - 'SHLVL': '1', 04:13:00 INFO - 'TERM': 'linux', 04:13:00 INFO - 'TMOUT': '86400', 04:13:00 INFO - 'USER': 'cltbld', 04:13:00 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1507029044.924251-868986532', 04:13:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:00 INFO - '_': '/tools/buildbot/bin/python'} 04:13:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:13:00 INFO - Running setup.py (path:/tmp/pip-EcRly5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:13:00 INFO - Running setup.py (path:/tmp/pip-MysHJ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:13:01 INFO - Running setup.py (path:/tmp/pip-dJNwmc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:13:01 INFO - Running setup.py (path:/tmp/pip-0NGZvR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:13:01 INFO - Running setup.py (path:/tmp/pip-FpvnLu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:13:01 INFO - Running setup.py (path:/tmp/pip-0wKJQJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:13:01 INFO - Running setup.py (path:/tmp/pip-xuAN3O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:13:01 INFO - Running setup.py (path:/tmp/pip-6vb6N8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:13:01 INFO - Running setup.py (path:/tmp/pip-LzeSCQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:13:01 INFO - Running setup.py (path:/tmp/pip-LjmJ0G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:13:01 INFO - Running setup.py (path:/tmp/pip-N6IsrG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:13:01 INFO - Running setup.py (path:/tmp/pip-czw1AQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:13:01 INFO - Running setup.py (path:/tmp/pip-dZ94Q7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:13:01 INFO - Running setup.py (path:/tmp/pip-bCQgdK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:13:01 INFO - Running setup.py (path:/tmp/pip-xMjED9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:13:01 INFO - Running setup.py (path:/tmp/pip-b7iXl6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:13:01 INFO - Running setup.py (path:/tmp/pip-3cW6km-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:13:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:13:02 INFO - Running setup.py install for manifestparser 04:13:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:13:02 INFO - Running setup.py install for mozcrash 04:13:02 INFO - Running setup.py install for mozdebug 04:13:02 INFO - Running setup.py install for mozdevice 04:13:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:13:02 INFO - Running setup.py install for mozfile 04:13:02 INFO - Running setup.py install for mozhttpd 04:13:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:13:02 INFO - Running setup.py install for mozinfo 04:13:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:13:02 INFO - Running setup.py install for mozInstall 04:13:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:13:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:13:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:13:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:13:02 INFO - Running setup.py install for mozleak 04:13:02 INFO - Running setup.py install for mozlog 04:13:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:13:03 INFO - Running setup.py install for moznetwork 04:13:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:13:03 INFO - Running setup.py install for mozprocess 04:13:03 INFO - Running setup.py install for mozprofile 04:13:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:13:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:13:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:13:03 INFO - Running setup.py install for mozrunner 04:13:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:13:03 INFO - Running setup.py install for mozscreenshot 04:13:03 INFO - Running setup.py install for moztest 04:13:03 INFO - Running setup.py install for mozversion 04:13:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:13:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:13:03 INFO - Cleaning up... 04:13:03 INFO - Return code: 0 04:13:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:13: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')]} 04:13:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13: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')]} 04:13:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:03 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 0xd2a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef2b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10979c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1094d60>, '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 0x1095a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1095ef0>, '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': '9531f05ccb2eabcb9acf5f1b000001c0-1507029044.924251-868986532', '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 04:13:03 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 04:13:03 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 04:13:03 INFO - Using env: {'DISPLAY': ':0', 04:13:03 INFO - 'HOME': '/home/cltbld', 04:13:03 INFO - 'LANG': 'en_US.UTF-8', 04:13:03 INFO - 'LANGUAGE': 'en_US:en', 04:13:03 INFO - 'LOGNAME': 'cltbld', 04:13:03 INFO - 'MAIL': '/var/mail/cltbld', 04:13:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:03 INFO - 'MOZ_NO_REMOTE': '1', 04:13:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:03 INFO - 'NO_EM_RESTART': '1', 04:13:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:03 INFO - 'PWD': '/builds/slave/test', 04:13:03 INFO - 'SHELL': '/bin/bash', 04:13:03 INFO - 'SHLVL': '1', 04:13:03 INFO - 'TERM': 'linux', 04:13:03 INFO - 'TMOUT': '86400', 04:13:03 INFO - 'USER': 'cltbld', 04:13:03 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1507029044.924251-868986532', 04:13:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:03 INFO - '_': '/tools/buildbot/bin/python'} 04:13:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:13:04 INFO - Running setup.py (path:/tmp/pip-rvQTZs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:13:04 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)) 04:13:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:13:04 INFO - Running setup.py (path:/tmp/pip-LvvR4e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:13:04 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)) 04:13:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:13:04 INFO - Running setup.py (path:/tmp/pip-goFwjI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:13:04 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)) 04:13:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:13:04 INFO - Running setup.py (path:/tmp/pip-Y8vGKL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:13:04 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)) 04:13:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:13:04 INFO - Running setup.py (path:/tmp/pip-NM6Q9D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:13:04 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)) 04:13:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:13:04 INFO - Running setup.py (path:/tmp/pip-jZPGCE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:13:04 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)) 04:13:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:13:04 INFO - Running setup.py (path:/tmp/pip-ZUqT0l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:13:04 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)) 04:13:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:13:04 INFO - Running setup.py (path:/tmp/pip-VHBr9L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:13:04 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)) 04:13:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:13:04 INFO - Running setup.py (path:/tmp/pip-Cerbve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:13:04 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)) 04:13:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:13:04 INFO - Running setup.py (path:/tmp/pip-e5gUkI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:13:04 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)) 04:13:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:13:04 INFO - Running setup.py (path:/tmp/pip-EyvPxn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:13:04 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)) 04:13:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:13:04 INFO - Running setup.py (path:/tmp/pip-b2oRq4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:13:04 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)) 04:13:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:13:04 INFO - Running setup.py (path:/tmp/pip-cE__1U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:13:04 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)) 04:13:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:13:05 INFO - Running setup.py (path:/tmp/pip-CSzmfx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:13:05 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)) 04:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:13:05 INFO - Running setup.py (path:/tmp/pip-YAVYTH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:13:05 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)) 04:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:13:05 INFO - Running setup.py (path:/tmp/pip-5TlGDt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:13:05 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)) 04:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:13:05 INFO - Running setup.py (path:/tmp/pip-aZCIuq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:13:05 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)) 04:13:05 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)) 04:13:05 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)) 04:13:05 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)) 04:13:05 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)) 04:13:05 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)) 04:13:05 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)) 04:13:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:13:05 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 04:13:05 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 04:13:05 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 04:13:05 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 04:13:06 INFO - Downloading blessings-1.6.tar.gz 04:13:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:13:06 INFO - Installing collected packages: blessings 04:13:06 INFO - Running setup.py install for blessings 04:13:06 INFO - Successfully installed blessings 04:13:06 INFO - Cleaning up... 04:13:06 INFO - Return code: 0 04:13:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:13:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:13:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:13:06 INFO - Reading from file tmpfile_stdout 04:13:06 INFO - Current package versions: 04:13:06 INFO - argparse == 1.2.1 04:13:06 INFO - blessings == 1.6 04:13:06 INFO - blobuploader == 1.2.4 04:13:06 INFO - docopt == 0.6.1 04:13:06 INFO - functools32 == 3.2.3-2 04:13:06 INFO - jsonschema == 2.5.1 04:13:06 INFO - manifestparser == 1.1 04:13:06 INFO - mozInstall == 1.13 04:13:06 INFO - mozcrash == 1.0 04:13:06 INFO - mozdebug == 0.1 04:13:06 INFO - mozdevice == 0.51 04:13:06 INFO - mozfile == 1.2 04:13:06 INFO - mozhttpd == 0.7 04:13:06 INFO - mozinfo == 0.10 04:13:06 INFO - mozleak == 0.1 04:13:06 INFO - mozlog == 3.5 04:13:06 INFO - moznetwork == 0.27 04:13:06 INFO - mozprocess == 0.25 04:13:06 INFO - mozprofile == 0.28 04:13:06 INFO - mozrunner == 6.13 04:13:06 INFO - mozscreenshot == 0.1 04:13:06 INFO - mozsystemmonitor == 0.3 04:13:06 INFO - moztest == 0.8 04:13:06 INFO - mozversion == 1.4 04:13:06 INFO - psutil == 3.1.1 04:13:06 INFO - requests == 1.2.3 04:13:06 INFO - wsgiref == 0.1.2 04:13:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:13:06 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')]} 04:13:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:06 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')]} 04:13:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:06 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 0xd2a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef2b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10979c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1094d60>, '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 0x1095a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1095ef0>, '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': '9531f05ccb2eabcb9acf5f1b000001c0-1507029044.924251-868986532', '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 04:13:06 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 04:13:06 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 04:13:06 INFO - Using env: {'DISPLAY': ':0', 04:13:06 INFO - 'HOME': '/home/cltbld', 04:13:06 INFO - 'LANG': 'en_US.UTF-8', 04:13:06 INFO - 'LANGUAGE': 'en_US:en', 04:13:06 INFO - 'LOGNAME': 'cltbld', 04:13:06 INFO - 'MAIL': '/var/mail/cltbld', 04:13:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:06 INFO - 'MOZ_NO_REMOTE': '1', 04:13:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:06 INFO - 'NO_EM_RESTART': '1', 04:13:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:06 INFO - 'PWD': '/builds/slave/test', 04:13:06 INFO - 'SHELL': '/bin/bash', 04:13:06 INFO - 'SHLVL': '1', 04:13:06 INFO - 'TERM': 'linux', 04:13:06 INFO - 'TMOUT': '86400', 04:13:06 INFO - 'USER': 'cltbld', 04:13:06 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1507029044.924251-868986532', 04:13:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:06 INFO - '_': '/tools/buildbot/bin/python'} 04:13:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:07 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)) 04:13:07 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)) 04:13:07 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)) 04:13:07 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)) 04:13:07 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)) 04:13:07 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)) 04:13:07 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)) 04:13:07 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)) 04:13:07 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)) 04:13:07 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 04:13: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 04:13: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 04:13: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 04:13: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 04:13:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 04:13:08 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)) 04:13:08 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)) 04:13:08 INFO - Installing collected packages: simplejson 04:13:08 INFO - Running setup.py install for simplejson 04:13:08 INFO - building 'simplejson._speedups' extension 04:13:08 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 04:13:09 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 04:13:09 INFO - Successfully installed simplejson 04:13:09 INFO - Cleaning up... 04:13:09 INFO - Return code: 0 04:13:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:13:09 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')]} 04:13:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:09 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')]} 04:13:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:09 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 0xd2a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef2b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10979c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1094d60>, '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 0x1095a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1095ef0>, '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': '9531f05ccb2eabcb9acf5f1b000001c0-1507029044.924251-868986532', '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 04:13:09 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 04:13:09 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 04:13:09 INFO - Using env: {'DISPLAY': ':0', 04:13:09 INFO - 'HOME': '/home/cltbld', 04:13:09 INFO - 'LANG': 'en_US.UTF-8', 04:13:09 INFO - 'LANGUAGE': 'en_US:en', 04:13:09 INFO - 'LOGNAME': 'cltbld', 04:13:09 INFO - 'MAIL': '/var/mail/cltbld', 04:13:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:09 INFO - 'MOZ_NO_REMOTE': '1', 04:13:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:09 INFO - 'NO_EM_RESTART': '1', 04:13:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:09 INFO - 'PWD': '/builds/slave/test', 04:13:09 INFO - 'SHELL': '/bin/bash', 04:13:09 INFO - 'SHLVL': '1', 04:13:09 INFO - 'TERM': 'linux', 04:13:09 INFO - 'TMOUT': '86400', 04:13:09 INFO - 'USER': 'cltbld', 04:13:09 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1507029044.924251-868986532', 04:13:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:09 INFO - '_': '/tools/buildbot/bin/python'} 04:13:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:13:09 INFO - Cleaning up... 04:13:09 INFO - Return code: 0 04:13:09 INFO - Running post-action listener: _resource_record_post_action 04:13:09 INFO - Running post-action listener: _start_resource_monitoring 04:13:09 INFO - Starting resource monitoring. 04:13:09 INFO - [mozharness: 2017-10-03 11:13:09.565110Z] Finished create-virtualenv step (success) 04:13:09 INFO - [mozharness: 2017-10-03 11:13:09.565616Z] Running install step. 04:13:09 INFO - Running pre-action listener: _resource_record_pre_action 04:13:09 INFO - Running main action method: install 04:13:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:13:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:13:09 INFO - Reading from file tmpfile_stdout 04:13:09 INFO - Detecting whether we're running mozinstall >=1.0... 04:13:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:13:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:13:09 INFO - Reading from file tmpfile_stdout 04:13:09 INFO - Output received: 04:13:09 INFO - Usage: mozinstall [options] installer 04:13:09 INFO - Options: 04:13:09 INFO - -h, --help show this help message and exit 04:13:09 INFO - -d DEST, --destination=DEST 04:13:09 INFO - Directory to install application into. [default: 04:13:09 INFO - "/builds/slave/test"] 04:13:09 INFO - --app=APP Application being installed. [default: firefox] 04:13:09 INFO - mkdir: /builds/slave/test/build/application 04:13:09 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'] 04:13:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 04:13:27 INFO - Reading from file tmpfile_stdout 04:13:27 INFO - Output received: 04:13:27 INFO - /builds/slave/test/build/application/firefox/firefox 04:13:27 INFO - Running post-action listener: _resource_record_post_action 04:13:27 INFO - [mozharness: 2017-10-03 11:13:27.611769Z] Finished install step (success) 04:13:27 INFO - [mozharness: 2017-10-03 11:13:27.612071Z] Running setup-mitmproxy step. 04:13:27 INFO - Running pre-action listener: _resource_record_pre_action 04:13:27 INFO - Running main action method: setup_mitmproxy 04:13:27 INFO - Skipping: mitmproxy is not required 04:13:27 INFO - Running post-action listener: _resource_record_post_action 04:13:27 INFO - [mozharness: 2017-10-03 11:13:27.613213Z] Finished setup-mitmproxy step (success) 04:13:27 INFO - [mozharness: 2017-10-03 11:13:27.613449Z] Running run-tests step. 04:13:27 INFO - Running pre-action listener: _resource_record_pre_action 04:13:27 INFO - Running pre-action listener: _set_gcov_prefix 04:13:27 INFO - Running main action method: run_tests 04:13:27 WARNING - Try message not found. 04:13:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:13:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:13:27 INFO - Python 2.7.3 04:13:27 INFO - Return code: 0 04:13:27 INFO - grabbing minidump binary from tooltool 04:13:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:13:27 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 0x1094d60>, '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 0x1095a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1095ef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:13:27 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 04:13:27 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 04:13:27 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 04:13:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:13:27 INFO - Return code: 0 04:13:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:13:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:13:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:13:27 INFO - ENV: RUST_BACKTRACE is now full 04:13:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:13:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:13:27 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/HK3Cnu3ZQ2u3dGHBaXWQPg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-073', '--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 04:13:27 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/HK3Cnu3ZQ2u3dGHBaXWQPg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-073 --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 04:13:27 INFO - Using env: {'DISPLAY': ':0', 04:13:27 INFO - 'HOME': '/home/cltbld', 04:13:27 INFO - 'LANG': 'en_US.UTF-8', 04:13:27 INFO - 'LANGUAGE': 'en_US:en', 04:13:27 INFO - 'LOGNAME': 'cltbld', 04:13:27 INFO - 'MAIL': '/var/mail/cltbld', 04:13:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:13:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:13:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:27 INFO - 'MOZ_NO_REMOTE': '1', 04:13:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:13:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:27 INFO - 'NO_EM_RESTART': '1', 04:13:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:27 INFO - 'PWD': '/builds/slave/test', 04:13:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:13:27 INFO - 'RUST_BACKTRACE': 'full', 04:13:27 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:13:27 INFO - 'SHELL': '/bin/bash', 04:13:27 INFO - 'SHLVL': '1', 04:13:27 INFO - 'TERM': 'linux', 04:13:27 INFO - 'TMOUT': '86400', 04:13:27 INFO - 'USER': 'cltbld', 04:13:27 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1507029044.924251-868986532', 04:13:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:27 INFO - '_': '/tools/buildbot/bin/python'} 04:13:27 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/HK3Cnu3ZQ2u3dGHBaXWQPg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-073', '--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 04:13:27 INFO - mozversion application_buildid: 20171003094409 04:13:27 INFO - mozversion application_changeset: 11fe0a2895aab26c57bcfe61b3041d7837e954cd 04:13:27 INFO - mozversion application_display_name: Nightly 04:13:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:13:27 INFO - mozversion application_name: Firefox 04:13:27 INFO - mozversion application_remotingname: firefox 04:13:27 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:13:27 INFO - mozversion application_vendor: Mozilla 04:13:27 INFO - mozversion application_version: 58.0a1 04:13:27 INFO - mozversion platform_buildid: 20171003094409 04:13:27 INFO - mozversion platform_changeset: 11fe0a2895aab26c57bcfe61b3041d7837e954cd 04:13:27 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:13:27 INFO - mozversion platform_version: 58.0a1 04:13:27 INFO - using testdate: 1507029207 04:13:27 INFO - actual date: 1507029207 04:13:27 INFO - starting webserver on 'localhost:54253' 04:13:27 INFO - SUITE-START | Running 2 tests 04:13:27 INFO - TEST-START | dromaeo_css 04:13:27 INFO - Initialising browser for dromaeo_css test... 04:13:27 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:54253/getInfo.html -profile /tmp/tmpZkxa2k/profile 04:13:27 INFO - TEST-INFO | started process 32284 (/builds/slave/test/build/application/firefox/firefox http://localhost:54253/getInfo.html) 04:13:33 INFO - TEST-INFO | 32284: exit 0 04:13:33 INFO - Browser initialized. 04:13:33 INFO - Running cycle 1/1 for dromaeo_css test... 04:13:33 INFO - Using env: {'DISPLAY': ':0', 04:13:33 INFO - 'HOME': '/home/cltbld', 04:13:33 INFO - 'JSGC_DISABLE_POISONING': '1', 04:13:33 INFO - 'LANG': 'en_US.UTF-8', 04:13:33 INFO - 'LANGUAGE': 'en_US:en', 04:13:33 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 04:13:33 INFO - 'LOGNAME': 'cltbld', 04:13:33 INFO - 'MAIL': '/var/mail/cltbld', 04:13:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:13:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:13:33 INFO - 'MOZ_CRASHREPORTER': '1', 04:13:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:33 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 04:13:33 INFO - 'MOZ_NO_REMOTE': '1', 04:13:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:13:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:33 INFO - 'NO_EM_RESTART': '1', 04:13:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:33 INFO - 'PWD': '/builds/slave/test', 04:13:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:13:33 INFO - 'RUST_BACKTRACE': 'full', 04:13:33 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:13:33 INFO - 'SHELL': '/bin/bash', 04:13:33 INFO - 'SHLVL': '1', 04:13:33 INFO - 'STYLO_FORCE_DISABLED': '1', 04:13:33 INFO - 'TERM': 'linux', 04:13:33 INFO - 'TMOUT': '86400', 04:13:33 INFO - 'USER': 'cltbld', 04:13:33 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1507029044.924251-868986532', 04:13:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:33 INFO - '_': '/tools/buildbot/bin/python'} 04:13:33 INFO - TEST-INFO | started process 32557 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZkxa2k/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:13:34 INFO - PID 32557 | 04:13:34 INFO - PID 32557 | (/builds/slave/test/build/application/firefox/firefox:32606): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:13:34 INFO - PID 32557 | 04:13:44 INFO - PID 32557 | RSS: Main: 145645568 04:13:44 INFO - PID 32557 | 04:16:42 INFO - PID 32557 | Cycle 1(1): loaded http://localhost:54253/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54253/tests/dromaeo/cssquery-ext.html) 04:16:43 INFO - PID 32557 | RSS: Main: 143138816 04:16:43 INFO - PID 32557 | 04:19:45 INFO - PID 32557 | Cycle 1(1): loaded http://localhost:54253/tests/dromaeo/cssquery-ext.html (next: http://localhost:54253/tests/dromaeo/cssquery-jquery.html) 04:19:45 INFO - PID 32557 | RSS: Main: 144191488 04:19:45 INFO - PID 32557 | 04:22:47 INFO - PID 32557 | Cycle 1(1): loaded http://localhost:54253/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54253/tests/dromaeo/cssquery-mootools.html) 04:22:47 INFO - PID 32557 | RSS: Main: 145600512 04:22:47 INFO - PID 32557 | 04:25:49 INFO - PID 32557 | Cycle 1(1): loaded http://localhost:54253/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54253/tests/dromaeo/cssquery-prototype.html) 04:25:50 INFO - PID 32557 | RSS: Main: 145952768 04:25:50 INFO - PID 32557 | 04:28:53 INFO - PID 32557 | Cycle 1(1): loaded http://localhost:54253/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54253/tests/dromaeo/cssquery-yui.html) 04:28:53 INFO - PID 32557 | RSS: Main: 147869696 04:28:53 INFO - PID 32557 | 04:31:55 INFO - PID 32557 | Cycle 1(1): loaded http://localhost:54253/tests/dromaeo/cssquery-yui.html (next: http://localhost:54253/tests/dromaeo/cssquery-dojo.html) 04:31:55 INFO - PID 32557 | RSS: Main: 149438464 04:31:55 INFO - PID 32557 | 04:31:55 INFO - PID 32557 | __start_tp_report 04:31:55 INFO - PID 32557 | _x_x_mozilla_page_load 04:31:55 INFO - PID 32557 | _x_x_mozilla_page_load_details 04:31:55 INFO - PID 32557 | |i|pagename|runs| 04:31:55 INFO - PID 32557 | |0;dojo.html;3889.6499315061646;3889.7860617666015;3897;3907.726459147859;3914.4324073009407;6276.905846412307;6301.149344838445;6360.872782544347;6399.392057754518;6445.774397896074;6382.648954307523;6383.904241436382;6403.679816009192;6431.324710905358;6436.6781660917;5662.462066103724;5670;5695.231143795576;5701.6864072476;5743.942560574383;5757.481826635602;5778.104393818965;5784.537237021028;5790.623609465392;5823.417658234164;5674.631148975324;5678.261825962619;5769.1346298055205;5772.076467765159;5780.1907732917425;5509.889802203974;5619.831405057814;5630.380658127603;5688.744006519716;5703.914441283384;5611.3546942101775;5616.241807356037;5656.236408084897;5671.744771485293;5672.092465205588;6206.968965155191;6274.247090349188;6282.340354262782;6284.402981716729;6331.525135614801;6765.695543700545;6804.591724496546;6834.2140653824945;6837.042814005993;6842.452603791735;6955.965220173917;6989.545679530815;6995.545289556214;7017.0526978857715;7045.048918396003;6402.93597064028;6413.0380442933465;6484.675766211671;6487.545871788977;6494.415502604741;6968.372846443743;6978.79063628092;7017.578945263301;7085.397741192057;7213.531120477152;6691.799246022627;6766.221884483249;6784.287649796799;6789.25318214996;6848.931510684829;6936.895946560705;6994.195667498201;7001.054857594261;7016;7021.192562855234;6869.622170780655;6892.448604111759;6944.861102777916;6972.442204623618;6973.12835895513;6744.730210791513;6827.897581536281;6862.519623626298;6884.036234927014;6915.308469153045;5081.872953176126;5088.77100530477;5102.872428189325;5103.030424219386;5107.438181799999;4458.665600080007;4530.388397566352;4547.181507328646;4596.310553416947;4642.767861606906;6263.812085637438;6321.399467050623;6344.873102537924;6345.777897773556;6346.460550853137;6838.794836154923;6840.213375461786;6923.030775691407;6925.376716095576;6949.166100068024;6202;6239.220097487814;6239.500839932794;6270.028145637433;6280.7487700491465;5469.316335458067;5504.174373843955;5547.306586676666;5550.417206193291;5559.332880054339;7076.752313668997;7100.822479437952;7162.534435261691;7165.749198778018;7181;6711.261761206166;6723.697433615401;6799.93200067993;6855.794326170223;6899.862002759816;7049.859002820018;7110.5022648414115;7112.395446387115;7168.713251469882;7248.746293879689;6895.6552172392185;6898.413634840894;6898.482613804085;6901.1718593769065;6902.965485172743;6832.624205668736;6840.589564626139;6899.379055884994;6909;6921.1002569667635;6555.115059466911;6683.933160668331;6687.598744075371;6706.362895524917;6781.38967492928;6554.115194448688;6671.299513551007;6680.5323627345615;6701.698423571049;6731.697073631796;6466.741330346734;6521.054447105238;6528.118703974903;6553.279139294578;6559.344065593403;6612.206535215805;6680.365365290289;6724.529282950147;6745.561538499982;6758.053872457958;6368.076628888878;6395.488360931207;6477.287498375269;6490.350964903472;6567.343265673395 04:31:55 INFO - PID 32557 | |1;ext.html;894.843402404579;965.8502932045533;984.8227319082562;987.2990176974353;995.6515219673113;46530.534694653084;47197.0560588788;47411.051778964444;47412.28881566771;47431.525684743145;44326.33510497345;44348;44358.778206109004;44383;44543.331850022194;7521.924780752191;7587.696492140308;7601.619919004055;7612.276833700789;7613.276738709814;7700.845983080363;7741.845163096763;7799.2590703883325;7818.569978651172;7839.804004899866;8344.165583441638;8603.44077634955;8609.39734218605;8618.78453038676;8623.913760862373;8488.872666910001;8512.74461766148;8518.87221691675;8568.357373197035;8575.656973721043;8152.225538573826;8380.958095209546;8401.075881653012;8468.66125354985;8571.271441927443;43277.783611081744;43760.562394375964;43824.780876095734;43834.342484862755;43844;3747.5502939647145;3759.812009399519;3781.7920014399197;3805.0867791729784;3807.1814559869485;33982;34132.48801267983;34186.48720269173;34219.6578034219;34240.315193695984;5518.779248830042;5533.557315414798;5540.556755459594;5555.861103472405;5559.19391688207;225438;228874;230132;230183;231091;48455.515444845805;48882.75558622255;55915;56560.43439565552;56584.71707641435;58911.41088589145;58937.70531147317;58954.41045589575;58986.705066474395;59013.11480327798;17176.141192940304;17403.129843507773;17419;17448;17467.56331091733;14090.225037622824;14307.141571505743;14311.713765724835;14315.212663303619;14340.498082567061;15486.22568871552;15496.52276800648;15582.9220853895;15589.922050389676;15593.376264949502;5941.970290148608;6088.056351265561;6138.974138534273;6192.195014648067;6192.473639740582;1099.631623406152;1103.172620534599;1103.7351035751522;1107.7175320293275;1122.3434290939729;26333.736662633513;26340.473190536082;26580.734192658212;26624.334391640365;27047.86476067607;1214.495984166561;1221.0780860450302;1241.1312081542956;1241.7081985733346;1244.5270797097226;13661.658458538417;13743.656408589864;13824.792628110587;14059.648508787157;14190.432382704783;279339;296841;304516;307744;308082;62376.376236237054;62485;62709.68645156745;62729.68635156795;63055;1545.1964978211493;1561.664242187935;1568.929398177062;1570.6151992761847;1570.9214539272991;26189.083382081535;26300.8684956574;26344.8682756585;26482.735172648026;26562.46875062449;43837.34243986279;43891.56108438875;43915.78042109769;43990;44085.77957110194;181696;182364;182396;182652;182755;38232.808835956756;40700.796496017334;41204.38193427161;41274;41487.1702565953;53029.7348513255;53917.460825392816;54157.72921135527;54490.72754636202;54541.72729136329;38748;38876.80561597174;39025.21949560936;39198.41202382024;39395.40906886342;38170;38253.234935300585;38328.42507362336;38459.42310865283;38647.22705545817;44055.33916991312;45388;45402;45955.54044459513;46008.769956150005;33093.33813323768;33148;33356.332873342886;33432.498512521845;33506.329873401904;27840.44319113647;28007.299817504725;28133.57799633048;28301.57547636746;28386.574201387408 04:31:55 INFO - PID 32557 | |2;jquery.html;603.6649659439009;612.8631388773824;625.6871564217892;626.8307556959621;643.1703102997134;23777.881110594466;23876.164334248304;24468.632970505456;24532.141375051877;24582.877085614593;25042.749572504268;25976.35059123523;26027.219183424528;26044;26055.60916586248;6537.80386588402;6616.106825578558;6682.99755036746;6684.298148694365;6689.799306020803;6364.84087897804;6608.70260838261;6691.665416729168;6740.258571557125;6742.797716068526;6684.29814869439;6692.431143352821;6698.83252918676;6698.8995165072565;6702.497312701543;6421.036844473319;6658.167729033871;6666.566673166253;6687.431568316674;6709.09427227323;6300.779472718433;6301.180846489973;6301.369863013708;6304.27500837405;6308.936910630927;29697.851510742523;29837.25406864824;30094.699053009626;30181.245468863235;30209;2270.0465804362207;2297.425643589103;2304.83866129371;2311.318161142467;2311.3759284992957;19360.903195483934;19652.70520942187;19885.20459181631;19904.303349382702;20441;2542.351700316426;2551.8596477193746;2626.4090579619624;2667.1331817159503;2696.4472283182095;137629;143739;161500;168251;170009.14995424944;16133.677326453406;16156.596085097966;16281.51155465338;16628.750568741478;16668.833311666727;26306.47387052248;26415.867920660272;26484;26497.205083847515;26519;10610.257281990187;10654.946725266323;10669.679909602724;10924.672259832218;10936.726581835517;9547.952260238655;9611.951940240393;9654.131128198356;9814.558344874498;9818.26363022776;10008.599656013677;10036.146927511243;10057.497125143713;10261.58953641846;10264.794704106025;3099.930523969227;3108.207407111172;3122.281875168724;3124.671909449475;3211;1050.6165249683963;1063.4576366053368;1072.8927107289364;1078.6224821312478;1081.4376524207369;20676.689849652266;21258.468538286357;21390.144394224368;21486.677699834516;21697.132114715234;1109.3011402816335;1110.8555887734542;1115.275071203724;1117.9217454778088;1121.4560937945091;11608.419579021016;11749.588764393206;11757.706057348634;11761.176717629683;11889.286642801286;618796;628868;632709;637448;666185;134676;135901;137241;139203;140486.29756851355;1133.5239199536215;1179.215821478707;1237.7276999060193;1252.248650809507;1293.1529847949796;21682.2411215613;22121.889390552944;22122.225722100295;22277.77722222822;22287;63694.36305636884;63726.362736372044;63920.680396597716;65401.67299163474;65949;82190.17809822064;82451;82847;82962.17037829544;85762.57118714367;15672.451464198699;15941;15983.28075236594;15995.440159594358;16126.838731612534;24226.75773242245;24425.26724198277;24462.510749785262;24699.382515437257;24756.50486990214;19619.803801961796;19837.30569430063;19850.50373740668;19938.102785374984;20222.494437638587;17145.31418743286;17152.828471715122;17159.485215443558;17309.134543272536;17519.124043798012;19532.414027579194;20500.17999280012;20553.691694624293;20592.485187870425;20725.68911466299;15562.533124006299;15615.687686246438;15716.842831571537;15731.292091856123;15750;19638.410847674593;19803.801961980196;19888.801111988694;20021.59956800885;20111 04:31:55 INFO - PID 32557 | |3;mootools.html;1462.0935020287423;1520.2246854104403;1529.1054732981206;1544.3050627217751;1547.4274518428183;17012.40456584018;17656;17696.20367083481;17721.64556708865;17731;17224.311027558913;17284.740728889046;17298.481045568653;17347;17401.564960875985;2806.6912639609627;2867.641544806899;2874.9712502874913;2888.4078763853463;2902.9129126126145;2628.316637674209;2628.6976997645324;2631.473705258946;2633.1573896353175;2636.1696065739325;2720.5511090670016;2779.8749056292513;2780.2215379693616;2781.068342105387;2781.4576157649267;2726.4138210284787;2762.9447411051665;2763.9447211055767;2764.1845655531665;2767.501849667059;2681.4313626528506;2713.2945434187054;2715.6876959149554;2716.9592456113173;2718.1573712149298;16643.41748038813;16746.581335466588;16798.58003549909;16880.409185678443;16953.491395258163;8135.918640813635;8524.78688032798;8535.914640853574;8540.103289154611;8548.78628034298;5035.370578677665;5325.946740532584;5478.205660179252;5503.422140675211;5631.324241091054;2001.6597178479694;2052.322733497942;2068.6896965455153;2100.5168811173517;2101.6006958677954;27227.183184504498;28292.15123546297;30847.69152308493;31750.523742143887;31814;7924.762257132295;8027.397945154137;8029.638666259915;8170.305524030524;8257.504549727035;23487.060517579106;23508.059677613044;23551.528969420517;23558.882205588863;23670.526589468114;8701.738947831574;8784.868226976601;8810.074942131112;8841.469511829311;8845.734627961172;7585.127710313274;7941.483803552751;8150.3479721622125;8215.917840821634;8222.17778222173;6168.444839964424;6193.256809182927;6228.377162283736;6278.748850045947;6297.779577714758;1953.64834329822;1957.6182644384494;1966.7934866839062;1967.7737060238255;1968.724378586999;926.7590426489027;940.1397721085131;949.8860136783492;950.5959967013991;953.2564599612314;8839.248663863515;8922.107789221156;8933.46399216049;9017.909820901707;9039.412438191497;797.2266901105918;799.1050023973187;802.3260461212609;802.9598520073973;813.9145389734111;5115.641905066684;5147.794088236504;5218.765155568009;5232.633715639945;5240.292560504283;24745.133920313063;25488;25626.103086391886;25888.74111258901;25913.740862591134;24371.878140609184;25217.74782252154;25307.873460632578;25419;25489;10599.205059620559;10981.17641176915;11451.828222576669;11915.52337906474;12067.818982715266;9414.435133891988;9510.667126650535;9637.855432168662;9638;9813.11681948628;21498.892505538;21543;21602.919854007552;21718.891405542872;22573.887130564242;22061.22785702557;22611;22751.772482274966;23081.422964426023;23365.649515256944;13281.40233689467;13328.866711332763;13384.063115582205;13390.26353550564;13489.730205396034;15170.544883653509;15296.464623738117;15314;15316.081035137928;15322.616934576725;12253.69365765863;12465.5013799447;12505.624831255076;12574.811377829157;12659.620211393672;12261.141720079866;12459.252444853339;12536.247825130522;12589.93705031469;12610.558630448257;10007.249456290952;10148.086672199537;10148.188144948534;10158.13655839262;10163.796724065625;8155.8192305002285;8257.628406721831;8320.625571849161;8382.16178382157;8421.07368189511;7800.531968081933;7898.565578893216;7917.841643167219;7971.561564114029;7995.920040799518 04:31:55 INFO - PID 32557 | |4;prototype.html;555.4695266020952;571.65414923971;574.5432381256902;583.2592607388614;594.5837913460579;6101.176341193937;6258.937410625898;6335.588186767863;6356.968215158918;6357.71390287437;6113.266408031042;6197;6233.189685340899;6264.686765661721;6309.990401535755;5070.72111033893;5099.694018358892;5106.897862042757;5107.4892510749;5114.335136432259;4877.561019508244;4987.127252730757;5013.470891378128;5030.396352437712;5037.3451451311275;4947.529984651453;4958.504149585031;4965.155923492996;4980.8544034872;4983.950160498385;4917.950820491785;4942.382202224704;4942.6293028022865;4951.356323677935;4966.553010229097;4517.390152329459;4580.106879158566;4609.331646911179;4609.400777898852;4622.306654001893;6206.751729930797;6232.563720539564;6243.282022567418;6265.71804268809;6267.905981410283;5835.591508594358;5858;5895.233619629464;5914.556408269354;5935.584509084366;6626.536142470029;6657.966710166466;6665.833354166136;6678.43233325168;6703.396694297488;4900.509949005107;5135.6918584885025;5139.794408223666;5151.304573882516;5156.407013193493;6666.100161453963;6798.592084474898;6813.4208592269715;6890.345417185359;6945.236024037352;5241.764120614582;5268.130758424893;5296.841094767163;5302.337207848942;5305.65513241638;5308.469153084738;5334.279872217278;5344.599155063386;5356.062689029404;5361.651492652965;5931.7923872665115;5955.255593050869;5957.940420595825;5969.641821490724;5987.161797348288;6493.285738568754;6634.635095069721;6642.900356494656;6645.3022432643875;6673.399394054559;1805.9006754628358;1836.7704036995376;1836.8163183681793;1839.567701590152;1853.6014756827346;1289.8710128987027;1311.8688131186805;1325.8143859859626;1336.7527007503643;1339.9280575539724;5965.494492313239;6005.927954855568;6041.607295525777;6066.211392519032;6104.938950610526;6662.6668666566475;6693.364130407604;6709.664516774142;6768.187817461936;6777;6030;6047.848803779941;6094.75620975156;6130.2030736004035;6136.938630613637;3522.260325331658;3526.8765593204116;3537.363274610595;3548.538689970287;3555.520004799319;6810.353016463428;6904.791661459224;6925.272846351161;6960.86760957561;6978;6720.227173875067;6791.966040169767;6857.142857142857;6873.4157596603845;6919.688614012382;6957.156353566309;7014.894776578355;7020.192677842114;7067.752628657972;7091.368985133448;6738.764143254963;6741.359570840762;6774.593524388552;6776.051352810512;6776.45788336922;6634.83412914681;6679.165104361955;6780.355866192704;6783.491238157059;6794.3545363190415;6937.306269373023;6944.4444444445335;7016.298370162943;7069.328413800887;7073.186583542958;5231.398389185292;5284.810917543522;5301.455301455246;5309.734513274244;5310.601704872227;6773.89839152423;6838.589684618939;6848.863022739617;6887.552309099892;6947.861042779015;6554.705038273194;6585.6377899216;6607.141071660653;6642.269350371359;6652.866942661023;6526.738930442919;6532.542722009413;6545.934540654723;6547;6610.8016759497295;6394.808155755335;6410.61536307823;6438.098666186644;6468.126802881551;6480.57876238043;6605;6616.172978377703;6618.933810662024;6656.134702488645;6688.765893193715;6117.52481529038;6319.273283572448;6374.840628984312;6378.202724659418;6383.265924418752 04:31:55 INFO - PID 32557 | |5;yui.html;936.9203617692496;952.3428834104467;989.2036910287216;992.4045572656407;1011.8128146292934;20022.29921952732;20037.799622003775;20136.597268054647;20350.898245508753;20463.897680511596;18695.158717857696;18969;19000.809991900078;19301.227950881985;19583.412497625057;1035.2856528995007;1051.0698032241482;1052.9894701053006;1056;1056.2183983851933;1038.870141232346;1067.359584249448;1068.177503322445;1072.2815713471994;1074.2265568790458;1126.3185772607578;1128.4527004402898;1129.0008342616802;1129.7571022230218;1131.1516362727955;1118.3513562133983;1125.6679279612533;1129.728865072385;1131.5869707556765;1131.773645270945;786.9331106855867;808.745245247751;818.5661599352353;818.7625588579305;831.717216146507;19534.12096455649;19668.213271469125;19966.401007969784;19993.200271989248;19999.10004049821;22306.88846555773;22326.888365558232;23019.1943281986;23083.307500775005;23263.53472930532;18543.165557549943;18765.34321298748;18869.716954245698;18874.52813679655;18901.33845315421;3900.102976315435;3933.6263055009726;3937.153511994935;3937.3700207966876;3937.409388591734;169901;170387;170582;171087;175618.99999999872;16835.32658693663;17520.21159047846;17533.473995780147;17804.3768468103;17981.190846411944;31140.065798026095;31198.84400578028;31220;31452.84273578663;31887.20281992922;8978.281737460988;9061.320400969953;9063.728088157366;9075.909240907638;9088.500132492776;4668.4631267404;4686.086213188396;4766.95233047672;4771.165046116916;4784.425868895755;6009.729562169713;6226.40849119333;6226.6575338355915;6229.875402491924;6256.092866534327;1032.3650954662828;1045.4929359260752;1059.7880423915249;1064.180580952662;1078.2021304234809;713.9607321597258;724.5906063074347;727.1819203396179;740.7148247924588;756.7729681095649;12523.812142817866;12526.801377428264;12756.043296752781;12913.225206487641;13279.867201328056;702.3152426384337;703.714995426853;710.6304721544768;712.7149140343904;727.1383410658386;5995.910061349084;6063.151158837766;6216.316205217422;6246.906296405557;6250.281217660027;158628;158996;162166;164367;166891;144234;145466;145628.27185864002;146893;148320;119887.40056299837;122744;122763.38618306852;122992;126425;11587.420628968686;11622.012128969132;11691.649250522498;11715.1799374043;11816.76366472683;56470.435295646515;57024.71487642535;57320.14019789623;57882.710586446796;58072.709636451546;77127.61436192783;78420.60789696015;79301.20698792938;79435;80336.59831700804;15872.127033013296;16142.273597687898;16274.593135171715;16355;16396;19314.613707726046;19614;19625.70561441608;19781.307654232034;19787.901060494605;16432.917835410746;16565.25456354443;16614.086225257728;16724.080175590458;16863.578410539834;17863.553411164823;18214.635707285513;18248.270069197082;18353.72469412933;18518.0740962954;17186.484405467854;17249.91375043117;17287.654246915245;17311.65376692434;17488.73766893523;11468.483918223534;11889.405529723652;11899.167058306182;12205;12380.62858114258;12474.563390281297;12497.18768280059;12535.185212961129;12593.811092833432;12791.808122877977 04:31:55 INFO - PID 32557 | __end_tp_report 04:31:55 INFO - PID 32557 | __start_cc_report 04:31:55 INFO - PID 32557 | _x_x_mozilla_cycle_collect,262 04:31:55 INFO - PID 32557 | __end_cc_report 04:31:55 INFO - PID 32557 | __startTimestamp1507030315408__endTimestamp 04:31:55 INFO - PID 32557 | 04:31:55 INFO - PID 32557 | ------- Summary: start ------- 04:31:55 INFO - PID 32557 | Number of tests: 6 04:31:55 INFO - PID 32557 | 04:31:55 INFO - PID 32557 | [#0] dojo.html Cycles:165 Average:6328.62 Median:6553.28 stddev:755.53 (11.5%) stddev-sans-first:733.22 04:31:55 INFO - PID 32557 | Values: 3889.6 3889.8 3897.0 3907.7 3914.4 6276.9 6301.1 6360.9 6399.4 6445.8 6382.6 6383.9 6403.7 6431.3 6436.7 5662.5 5670.0 5695.2 5701.7 5743.9 5757.5 5778.1 5784.5 5790.6 5823.4 5674.6 5678.3 5769.1 5772.1 5780.2 5509.9 5619.8 5630.4 5688.7 5703.9 5611.4 5616.2 5656.2 5671.7 5672.1 6207.0 6274.2 6282.3 6284.4 6331.5 6765.7 6804.6 6834.2 6837.0 6842.5 6956.0 6989.5 6995.5 7017.1 7045.0 6402.9 6413.0 6484.7 6487.5 6494.4 6968.4 6978.8 7017.6 7085.4 7213.5 6691.8 6766.2 6784.3 6789.3 6848.9 6936.9 6994.2 7001.1 7016.0 7021.2 6869.6 6892.4 6944.9 6972.4 6973.1 6744.7 6827.9 6862.5 6884.0 6915.3 5081.9 5088.8 5102.9 5103.0 5107.4 4458.7 4530.4 4547.2 4596.3 4642.8 6263.8 6321.4 6344.9 6345.8 6346.5 6838.8 6840.2 6923.0 6925.4 6949.2 6202.0 6239.2 6239.5 6270.0 6280.7 5469.3 5504.2 5547.3 5550.4 5559.3 7076.8 7100.8 7162.5 7165.7 7181.0 6711.3 6723.7 6799.9 6855.8 6899.9 7049.9 7110.5 7112.4 7168.7 7248.7 6895.7 6898.4 6898.5 6901.2 6903.0 6832.6 6840.6 6899.4 6909.0 6921.1 6555.1 6683.9 6687.6 6706.4 6781.4 6554.1 6671.3 6680.5 6701.7 6731.7 6466.7 6521.1 6528.1 6553.3 6559.3 6612.2 6680.4 6724.5 6745.6 6758.1 6368.1 6395.5 6477.3 6490.4 6567.3 04:31:55 INFO - PID 32557 | 04:31:55 INFO - PID 32557 | [#1] ext.html Cycles:180 Average:43143.77 Median:40048.10 stddev:63027.35 (157.4%) stddev-sans-first:63124.33 04:31:55 INFO - PID 32557 | Values: 894.8 965.9 984.8 987.3 995.7 46530.5 47197.1 47411.1 47412.3 47431.5 44326.3 44348.0 44358.8 44383.0 44543.3 7521.9 7587.7 7601.6 7612.3 7613.3 7700.8 7741.8 7799.3 7818.6 7839.8 8344.2 8603.4 8609.4 8618.8 8623.9 8488.9 8512.7 8518.9 8568.4 8575.7 8152.2 8381.0 8401.1 8468.7 8571.3 43277.8 43760.6 43824.8 43834.3 43844.0 3747.6 3759.8 3781.8 3805.1 3807.2 33982.0 34132.5 34186.5 34219.7 34240.3 5518.8 5533.6 5540.6 5555.9 5559.2 225438.0 228874.0 230132.0 230183.0 231091.0 48455.5 48882.8 55915.0 56560.4 56584.7 58911.4 58937.7 58954.4 58986.7 59013.1 17176.1 17403.1 17419.0 17448.0 17467.6 14090.2 14307.1 14311.7 14315.2 14340.5 15486.2 15496.5 15582.9 15589.9 15593.4 5942.0 6088.1 6139.0 6192.2 6192.5 1099.6 1103.2 1103.7 1107.7 1122.3 26333.7 26340.5 26580.7 26624.3 27047.9 1214.5 1221.1 1241.1 1241.7 1244.5 13661.7 13743.7 13824.8 14059.6 14190.4 279339.0 296841.0 304516.0 307744.0 308082.0 62376.4 62485.0 62709.7 62729.7 63055.0 1545.2 1561.7 1568.9 1570.6 1570.9 26189.1 26300.9 26344.9 26482.7 26562.5 43837.3 43891.6 43915.8 43990.0 44085.8 181696.0 182364.0 182396.0 182652.0 182755.0 38232.8 40700.8 41204.4 41274.0 41487.2 53029.7 53917.5 54157.7 54490.7 54541.7 38748.0 38876.8 39025.2 39198.4 39395.4 38170.0 38253.2 38328.4 38459.4 38647.2 44055.3 45388.0 45402.0 45955.5 46008.8 33093.3 33148.0 33356.3 33432.5 33506.3 27840.4 28007.3 28133.6 28301.6 28386.6 04:31:55 INFO - PID 32557 | 04:31:55 INFO - PID 32557 | [#2] jquery.html Cycles:180 Average:41258.79 Median:2283.74 stddev:106602.30 (4667.9%) stddev-sans-first:106857.64 04:31:55 INFO - PID 32557 | Values: 603.7 612.9 625.7 626.8 643.2 23777.9 23876.2 24468.6 24532.1 24582.9 25042.7 25976.4 26027.2 26044.0 26055.6 6537.8 6616.1 6683.0 6684.3 6689.8 6364.8 6608.7 6691.7 6740.3 6742.8 6684.3 6692.4 6698.8 6698.9 6702.5 6421.0 6658.2 6666.6 6687.4 6709.1 6300.8 6301.2 6301.4 6304.3 6308.9 29697.9 29837.3 30094.7 30181.2 30209.0 2270.0 2297.4 2304.8 2311.3 2311.4 19360.9 19652.7 19885.2 19904.3 20441.0 2542.4 2551.9 2626.4 2667.1 2696.4 137629.0 143739.0 161500.0 168251.0 170009.1 16133.7 16156.6 16281.5 16628.8 16668.8 26306.5 26415.9 26484.0 26497.2 26519.0 10610.3 10654.9 10669.7 10924.7 10936.7 9548.0 9612.0 9654.1 9814.6 9818.3 10008.6 10036.1 10057.5 10261.6 10264.8 3099.9 3108.2 3122.3 3124.7 3211.0 1050.6 1063.5 1072.9 1078.6 1081.4 20676.7 21258.5 21390.1 21486.7 21697.1 1109.3 1110.9 1115.3 1117.9 1121.5 11608.4 11749.6 11757.7 11761.2 11889.3 618796.0 628868.0 632709.0 637448.0 666185.0 134676.0 135901.0 137241.0 139203.0 140486.3 1133.5 1179.2 1237.7 1252.2 1293.2 21682.2 22121.9 22122.2 22277.8 22287.0 63694.4 63726.4 63920.7 65401.7 65949.0 82190.2 82451.0 82847.0 82962.2 85762.6 15672.5 15941.0 15983.3 15995.4 16126.8 24226.8 24425.3 24462.5 24699.4 24756.5 19619.8 19837.3 19850.5 19938.1 20222.5 17145.3 17152.8 17159.5 17309.1 17519.1 19532.4 20500.2 20553.7 20592.5 20725.7 15562.5 15615.7 15716.8 15731.3 15750.0 19638.4 19803.8 19888.8 20021.6 20111.0 04:31:55 INFO - PID 32557 | 04:31:55 INFO - PID 32557 | [#3] mootools.html Cycles:180 Average:10600.89 Median:2697.36 stddev:7956.76 (295.0%) stddev-sans-first:7949.46 04:31:55 INFO - PID 32557 | Values: 1462.1 1520.2 1529.1 1544.3 1547.4 17012.4 17656.0 17696.2 17721.6 17731.0 17224.3 17284.7 17298.5 17347.0 17401.6 2806.7 2867.6 2875.0 2888.4 2902.9 2628.3 2628.7 2631.5 2633.2 2636.2 2720.6 2779.9 2780.2 2781.1 2781.5 2726.4 2762.9 2763.9 2764.2 2767.5 2681.4 2713.3 2715.7 2717.0 2718.2 16643.4 16746.6 16798.6 16880.4 16953.5 8135.9 8524.8 8535.9 8540.1 8548.8 5035.4 5325.9 5478.2 5503.4 5631.3 2001.7 2052.3 2068.7 2100.5 2101.6 27227.2 28292.2 30847.7 31750.5 31814.0 7924.8 8027.4 8029.6 8170.3 8257.5 23487.1 23508.1 23551.5 23558.9 23670.5 8701.7 8784.9 8810.1 8841.5 8845.7 7585.1 7941.5 8150.3 8215.9 8222.2 6168.4 6193.3 6228.4 6278.7 6297.8 1953.6 1957.6 1966.8 1967.8 1968.7 926.8 940.1 949.9 950.6 953.3 8839.2 8922.1 8933.5 9017.9 9039.4 797.2 799.1 802.3 803.0 813.9 5115.6 5147.8 5218.8 5232.6 5240.3 24745.1 25488.0 25626.1 25888.7 25913.7 24371.9 25217.7 25307.9 25419.0 25489.0 10599.2 10981.2 11451.8 11915.5 12067.8 9414.4 9510.7 9637.9 9638.0 9813.1 21498.9 21543.0 21602.9 21718.9 22573.9 22061.2 22611.0 22751.8 23081.4 23365.6 13281.4 13328.9 13384.1 13390.3 13489.7 15170.5 15296.5 15314.0 15316.1 15322.6 12253.7 12465.5 12505.6 12574.8 12659.6 12261.1 12459.3 12536.2 12589.9 12610.6 10007.2 10148.1 10148.2 10158.1 10163.8 8155.8 8257.6 8320.6 8382.2 8421.1 7800.5 7898.6 7917.8 7971.6 7995.9 04:31:55 INFO - PID 32557 | 04:31:55 INFO - PID 32557 | [#4] prototype.html Cycles:180 Average:5641.95 Median:6232.88 stddev:1563.89 (25.1%) stddev-sans-first:1520.97 04:31:55 INFO - PID 32557 | Values: 555.5 571.7 574.5 583.3 594.6 6101.2 6258.9 6335.6 6357.0 6357.7 6113.3 6197.0 6233.2 6264.7 6310.0 5070.7 5099.7 5106.9 5107.5 5114.3 4877.6 4987.1 5013.5 5030.4 5037.3 4947.5 4958.5 4965.2 4980.9 4984.0 4918.0 4942.4 4942.6 4951.4 4966.6 4517.4 4580.1 4609.3 4609.4 4622.3 6206.8 6232.6 6243.3 6265.7 6267.9 5835.6 5858.0 5895.2 5914.6 5935.6 6626.5 6658.0 6665.8 6678.4 6703.4 4900.5 5135.7 5139.8 5151.3 5156.4 6666.1 6798.6 6813.4 6890.3 6945.2 5241.8 5268.1 5296.8 5302.3 5305.7 5308.5 5334.3 5344.6 5356.1 5361.7 5931.8 5955.3 5957.9 5969.6 5987.2 6493.3 6634.6 6642.9 6645.3 6673.4 1805.9 1836.8 1836.8 1839.6 1853.6 1289.9 1311.9 1325.8 1336.8 1339.9 5965.5 6005.9 6041.6 6066.2 6104.9 6662.7 6693.4 6709.7 6768.2 6777.0 6030.0 6047.8 6094.8 6130.2 6136.9 3522.3 3526.9 3537.4 3548.5 3555.5 6810.4 6904.8 6925.3 6960.9 6978.0 6720.2 6792.0 6857.1 6873.4 6919.7 6957.2 7014.9 7020.2 7067.8 7091.4 6738.8 6741.4 6774.6 6776.1 6776.5 6634.8 6679.2 6780.4 6783.5 6794.4 6937.3 6944.4 7016.3 7069.3 7073.2 5231.4 5284.8 5301.5 5309.7 5310.6 6773.9 6838.6 6848.9 6887.6 6947.9 6554.7 6585.6 6607.1 6642.3 6652.9 6526.7 6532.5 6545.9 6547.0 6610.8 6394.8 6410.6 6438.1 6468.1 6480.6 6605.0 6616.2 6618.9 6656.1 6688.8 6117.5 6319.3 6374.8 6378.2 6383.3 04:31:55 INFO - PID 32557 | 04:31:55 INFO - PID 32557 | [#5] yui.html Cycles:180 Average:29569.37 Median:18530.62 stddev:46061.91 (248.6%) stddev-sans-first:46140.95 04:31:55 INFO - PID 32557 | Values: 936.9 952.3 989.2 992.4 1011.8 20022.3 20037.8 20136.6 20350.9 20463.9 18695.2 18969.0 19000.8 19301.2 19583.4 1035.3 1051.1 1053.0 1056.0 1056.2 1038.9 1067.4 1068.2 1072.3 1074.2 1126.3 1128.5 1129.0 1129.8 1131.2 1118.4 1125.7 1129.7 1131.6 1131.8 786.9 808.7 818.6 818.8 831.7 19534.1 19668.2 19966.4 19993.2 19999.1 22306.9 22326.9 23019.2 23083.3 23263.5 18543.2 18765.3 18869.7 18874.5 18901.3 3900.1 3933.6 3937.2 3937.4 3937.4 169901.0 170387.0 170582.0 171087.0 175619.0 16835.3 17520.2 17533.5 17804.4 17981.2 31140.1 31198.8 31220.0 31452.8 31887.2 8978.3 9061.3 9063.7 9075.9 9088.5 4668.5 4686.1 4767.0 4771.2 4784.4 6009.7 6226.4 6226.7 6229.9 6256.1 1032.4 1045.5 1059.8 1064.2 1078.2 714.0 724.6 727.2 740.7 756.8 12523.8 12526.8 12756.0 12913.2 13279.9 702.3 703.7 710.6 712.7 727.1 5995.9 6063.2 6216.3 6246.9 6250.3 158628.0 158996.0 162166.0 164367.0 166891.0 144234.0 145466.0 145628.3 146893.0 148320.0 119887.4 122744.0 122763.4 122992.0 126425.0 11587.4 11622.0 11691.6 11715.2 11816.8 56470.4 57024.7 57320.1 57882.7 58072.7 77127.6 78420.6 79301.2 79435.0 80336.6 15872.1 16142.3 16274.6 16355.0 16396.0 19314.6 19614.0 19625.7 19781.3 19787.9 16432.9 16565.3 16614.1 16724.1 16863.6 17863.6 18214.6 18248.3 18353.7 18518.1 17186.5 17249.9 17287.7 17311.7 17488.7 11468.5 11889.4 11899.2 12205.0 12380.6 12474.6 12497.2 12535.2 12593.8 12791.8 04:31:55 INFO - PID 32557 | -------- Summary: end -------- 04:31:55 INFO - PID 32557 | 04:31:56 INFO - TEST-INFO | 32557: exit 0 04:31:56 INFO - TEST-OK | dromaeo_css | took 1108115ms 04:31:56 INFO - TEST-START | kraken 04:31:56 INFO - Initialising browser for kraken test... 04:31:56 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:54253/getInfo.html -profile /tmp/tmpSDqPxT/profile 04:31:56 INFO - TEST-INFO | started process 491 (/builds/slave/test/build/application/firefox/firefox http://localhost:54253/getInfo.html) 04:32:00 INFO - TEST-INFO | 491: exit 0 04:32:01 INFO - Browser initialized. 04:32:01 INFO - Running cycle 1/1 for kraken test... 04:32:01 INFO - Using env: {'DISPLAY': ':0', 04:32:01 INFO - 'HOME': '/home/cltbld', 04:32:01 INFO - 'JSGC_DISABLE_POISONING': '1', 04:32:01 INFO - 'LANG': 'en_US.UTF-8', 04:32:01 INFO - 'LANGUAGE': 'en_US:en', 04:32:01 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 04:32:01 INFO - 'LOGNAME': 'cltbld', 04:32:01 INFO - 'MAIL': '/var/mail/cltbld', 04:32:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:32:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:32:01 INFO - 'MOZ_CRASHREPORTER': '1', 04:32:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:01 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 04:32:01 INFO - 'MOZ_NO_REMOTE': '1', 04:32:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:32:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:32:01 INFO - 'NO_EM_RESTART': '1', 04:32:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:32:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:01 INFO - 'PWD': '/builds/slave/test', 04:32:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:32:01 INFO - 'RUST_BACKTRACE': 'full', 04:32:01 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:32:01 INFO - 'SHELL': '/bin/bash', 04:32:01 INFO - 'SHLVL': '1', 04:32:01 INFO - 'STYLO_FORCE_DISABLED': '1', 04:32:01 INFO - 'TERM': 'linux', 04:32:01 INFO - 'TMOUT': '86400', 04:32:01 INFO - 'USER': 'cltbld', 04:32:01 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1507029044.924251-868986532', 04:32:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:01 INFO - '_': '/tools/buildbot/bin/python'} 04:32:01 INFO - TEST-INFO | started process 773 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSDqPxT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:32:01 INFO - PID 773 | 04:32:01 INFO - PID 773 | (/builds/slave/test/build/application/firefox/firefox:824): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:32:01 INFO - PID 773 | 04:32:12 INFO - PID 773 | RSS: Main: 146116608 04:32:12 INFO - PID 773 | 04:32:14 INFO - PID 773 | Cycle 1(1): loaded http://localhost:54253/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54253/tests/kraken/driver.html?testName=audio-beat-detection) 04:32:15 INFO - PID 773 | RSS: Main: 152330240 04:32:15 INFO - PID 773 | 04:32:18 INFO - PID 773 | Cycle 1(1): loaded http://localhost:54253/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54253/tests/kraken/driver.html?testName=audio-dft) 04:32:18 INFO - PID 773 | RSS: Main: 151937024 04:32:18 INFO - PID 773 | 04:32:21 INFO - PID 773 | Cycle 1(1): loaded http://localhost:54253/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54253/tests/kraken/driver.html?testName=audio-fft) 04:32:22 INFO - PID 773 | RSS: Main: 149241856 04:32:22 INFO - PID 773 | 04:32:24 INFO - PID 773 | Cycle 1(1): loaded http://localhost:54253/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54253/tests/kraken/driver.html?testName=audio-oscillator) 04:32:24 INFO - PID 773 | RSS: Main: 149549056 04:32:24 INFO - PID 773 | 04:32:26 INFO - PID 773 | Cycle 1(1): loaded http://localhost:54253/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54253/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:32:27 INFO - PID 773 | RSS: Main: 149479424 04:32:27 INFO - PID 773 | 04:32:30 INFO - PID 773 | Cycle 1(1): loaded http://localhost:54253/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54253/tests/kraken/driver.html?testName=imaging-darkroom) 04:32:31 INFO - PID 773 | RSS: Main: 149319680 04:32:31 INFO - PID 773 | 04:32:34 INFO - PID 773 | Cycle 1(1): loaded http://localhost:54253/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54253/tests/kraken/driver.html?testName=imaging-desaturate) 04:32:35 INFO - PID 773 | RSS: Main: 150339584 04:32:35 INFO - PID 773 | 04:32:38 INFO - PID 773 | Cycle 1(1): loaded http://localhost:54253/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54253/tests/kraken/driver.html?testName=json-parse-financial) 04:32:38 INFO - PID 773 | RSS: Main: 152182784 04:32:38 INFO - PID 773 | 04:32:40 INFO - PID 773 | Cycle 1(1): loaded http://localhost:54253/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54253/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:32:40 INFO - PID 773 | RSS: Main: 152440832 04:32:40 INFO - PID 773 | 04:32:42 INFO - PID 773 | Cycle 1(1): loaded http://localhost:54253/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54253/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:32:43 INFO - PID 773 | RSS: Main: 152186880 04:32:43 INFO - PID 773 | 04:32:45 INFO - PID 773 | Cycle 1(1): loaded http://localhost:54253/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54253/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:32:45 INFO - PID 773 | RSS: Main: 149180416 04:32:45 INFO - PID 773 | 04:32:48 INFO - PID 773 | Cycle 1(1): loaded http://localhost:54253/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54253/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:32:48 INFO - PID 773 | RSS: Main: 149725184 04:32:48 INFO - PID 773 | 04:32:51 INFO - PID 773 | Cycle 1(1): loaded http://localhost:54253/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54253/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:32:52 INFO - PID 773 | RSS: Main: 149499904 04:32:52 INFO - PID 773 | 04:32:53 INFO - PID 773 | Cycle 1(1): loaded http://localhost:54253/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54253/tests/kraken/driver.html?testName=ai-astar) 04:32:54 INFO - PID 773 | RSS: Main: 151166976 04:32:54 INFO - PID 773 | 04:32:54 INFO - PID 773 | __start_tp_report 04:32:54 INFO - PID 773 | _x_x_mozilla_page_load 04:32:54 INFO - PID 773 | _x_x_mozilla_page_load_details 04:32:54 INFO - PID 773 | |i|pagename|runs| 04:32:54 INFO - PID 773 | |0;ai-astar;107;104;105;104;107;108;106;105;104;103 04:32:54 INFO - PID 773 | |1;audio-beat-detection;110;116;112;111;113;111;113;144;113;114 04:32:54 INFO - PID 773 | |2;audio-dft;163;162;163;161;161;162;161;162;161;167 04:32:54 INFO - PID 773 | |3;audio-fft;73;75;72;73;73;73;75;73;73;74 04:32:54 INFO - PID 773 | |4;audio-oscillator;87;79;79;77;77;80;77;77;78;79 04:32:54 INFO - PID 773 | |5;imaging-gaussian-blur;110;114;115;113;114;114;113;114;113;115 04:32:54 INFO - PID 773 | |6;imaging-darkroom;149;150;150;149;148;149;150;149;150;150 04:32:54 INFO - PID 773 | |7;imaging-desaturate;98;98;94;95;94;94;95;95;95;94 04:32:54 INFO - PID 773 | |8;json-parse-financial;45;45;44;50;44;44;43;46;46;43 04:32:54 INFO - PID 773 | |9;json-stringify-tinderbox;36;35;37;36;36;36;36;36;35;36 04:32:54 INFO - PID 773 | |10;stanford-crypto-aes;70;71;69;69;70;70;70;66;76;71 04:32:54 INFO - PID 773 | |11;stanford-crypto-ccm;103;103;102;106;109;106;115;108;107;102 04:32:54 INFO - PID 773 | |12;stanford-crypto-pbkdf2;164;150;147;149;147;145;145;150;147;148 04:32:54 INFO - PID 773 | |13;stanford-crypto-sha256-iterative;59;59;59;62;65;64;66;59;60;67 04:32:54 INFO - PID 773 | __end_tp_report 04:32:54 INFO - PID 773 | __start_cc_report 04:32:54 INFO - PID 773 | _x_x_mozilla_cycle_collect,705 04:32:54 INFO - PID 773 | __end_cc_report 04:32:54 INFO - PID 773 | __startTimestamp1507030374006__endTimestamp 04:32:54 INFO - PID 773 | 04:32:54 INFO - PID 773 | ------- Summary: start ------- 04:32:54 INFO - PID 773 | Number of tests: 14 04:32:54 INFO - PID 773 | 04:32:54 INFO - PID 773 | [#0] ai-astar Cycles:10 Average:105.30 Median:105.50 stddev:1.64 (1.6%) stddev-sans-first:1.62 04:32:54 INFO - PID 773 | Values: 107.0 104.0 105.0 104.0 107.0 108.0 106.0 105.0 104.0 103.0 04:32:54 INFO - PID 773 | 04:32:54 INFO - PID 773 | [#1] audio-beat-detection Cycles:10 Average:115.70 Median:113.00 stddev:10.09 (8.9%) stddev-sans-first:10.49 04:32:54 INFO - PID 773 | Values: 110.0 116.0 112.0 111.0 113.0 111.0 113.0 144.0 113.0 114.0 04:32:54 INFO - PID 773 | 04:32:54 INFO - PID 773 | [#2] audio-dft Cycles:10 Average:162.30 Median:162.00 stddev:1.83 (1.1%) stddev-sans-first:1.92 04:32:54 INFO - PID 773 | Values: 163.0 162.0 163.0 161.0 161.0 162.0 161.0 162.0 161.0 167.0 04:32:54 INFO - PID 773 | 04:32:54 INFO - PID 773 | [#3] audio-fft Cycles:10 Average:73.40 Median:73.00 stddev:0.97 (1.3%) stddev-sans-first:1.01 04:32:54 INFO - PID 773 | Values: 73.0 75.0 72.0 73.0 73.0 73.0 75.0 73.0 73.0 74.0 04:32:54 INFO - PID 773 | 04:32:54 INFO - PID 773 | [#4] audio-oscillator Cycles:10 Average:79.00 Median:79.00 stddev:3.02 (3.8%) stddev-sans-first:1.17 04:32:54 INFO - PID 773 | Values: 87.0 79.0 79.0 77.0 77.0 80.0 77.0 77.0 78.0 79.0 04:32:54 INFO - PID 773 | 04:32:54 INFO - PID 773 | [#5] imaging-gaussian-blur Cycles:10 Average:113.50 Median:114.00 stddev:1.43 (1.3%) stddev-sans-first:0.78 04:32:54 INFO - PID 773 | Values: 110.0 114.0 115.0 113.0 114.0 114.0 113.0 114.0 113.0 115.0 04:32:54 INFO - PID 773 | 04:32:54 INFO - PID 773 | [#6] imaging-darkroom Cycles:10 Average:149.40 Median:150.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 04:32:54 INFO - PID 773 | Values: 149.0 150.0 150.0 149.0 148.0 149.0 150.0 149.0 150.0 150.0 04:32:54 INFO - PID 773 | 04:32:54 INFO - PID 773 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:1.55 (1.6%) stddev-sans-first:1.27 04:32:54 INFO - PID 773 | Values: 98.0 98.0 94.0 95.0 94.0 94.0 95.0 95.0 95.0 94.0 04:32:54 INFO - PID 773 | 04:32:54 INFO - PID 773 | [#8] json-parse-financial Cycles:10 Average:45.00 Median:45.00 stddev:2.05 (4.6%) stddev-sans-first:2.18 04:32:54 INFO - PID 773 | Values: 45.0 45.0 44.0 50.0 44.0 44.0 43.0 46.0 46.0 43.0 04:32:54 INFO - PID 773 | 04:32:54 INFO - PID 773 | [#9] json-stringify-tinderbox Cycles:10 Average:35.90 Median:36.00 stddev:0.57 (1.6%) stddev-sans-first:0.60 04:32:54 INFO - PID 773 | Values: 36.0 35.0 37.0 36.0 36.0 36.0 36.0 36.0 35.0 36.0 04:32:54 INFO - PID 773 | 04:32:54 INFO - PID 773 | [#10] stanford-crypto-aes Cycles:10 Average:70.20 Median:70.00 stddev:2.49 (3.6%) stddev-sans-first:2.64 04:32:54 INFO - PID 773 | Values: 70.0 71.0 69.0 69.0 70.0 70.0 70.0 66.0 76.0 71.0 04:32:54 INFO - PID 773 | 04:32:54 INFO - PID 773 | [#11] stanford-crypto-ccm Cycles:10 Average:106.10 Median:106.50 stddev:4.01 (3.8%) stddev-sans-first:4.10 04:32:54 INFO - PID 773 | Values: 103.0 103.0 102.0 106.0 109.0 106.0 115.0 108.0 107.0 102.0 04:32:54 INFO - PID 773 | 04:32:54 INFO - PID 773 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.20 Median:148.50 stddev:5.49 (3.7%) stddev-sans-first:1.88 04:32:54 INFO - PID 773 | Values: 164.0 150.0 147.0 149.0 147.0 145.0 145.0 150.0 147.0 148.0 04:32:54 INFO - PID 773 | 04:32:54 INFO - PID 773 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.00 Median:63.00 stddev:3.23 (5.1%) stddev-sans-first:3.24 04:32:54 INFO - PID 773 | Values: 59.0 59.0 59.0 62.0 65.0 64.0 66.0 59.0 60.0 67.0 04:32:54 INFO - PID 773 | -------- Summary: end -------- 04:32:54 INFO - PID 773 | 04:32:54 INFO - PID 773 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 04:32:54 INFO - TEST-INFO | 773: exit 0 04:32:54 INFO - TEST-OK | kraken | took 58548ms 04:32:54 INFO - SUITE-END | took 1166s 04:32:54 INFO - Completed test suite (00:19:26) 04:32:54 INFO - javascript benchmark 04:32:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9160.350049964327, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3889.6499315061646, 3889.7860617666015, 3897.0, 3907.726459147859, 3914.4324073009407, 6276.905846412307, 6301.149344838445, 6360.872782544347, 6399.392057754518, 6445.774397896074, 6382.648954307523, 6383.904241436382, 6403.679816009192, 6431.324710905358, 6436.6781660917, 5662.462066103724, 5670.0, 5695.231143795576, 5701.6864072476, 5743.942560574383, 5757.481826635602, 5778.104393818965, 5784.537237021028, 5790.623609465392, 5823.417658234164, 5674.631148975324, 5678.261825962619, 5769.1346298055205, 5772.076467765159, 5780.1907732917425, 5509.889802203974, 5619.831405057814, 5630.380658127603, 5688.744006519716, 5703.914441283384, 5611.3546942101775, 5616.241807356037, 5656.236408084897, 5671.744771485293, 5672.092465205588, 6206.968965155191, 6274.247090349188, 6282.340354262782, 6284.402981716729, 6331.525135614801, 6765.695543700545, 6804.591724496546, 6834.2140653824945, 6837.042814005993, 6842.452603791735, 6955.965220173917, 6989.545679530815, 6995.545289556214, 7017.0526978857715, 7045.048918396003, 6402.93597064028, 6413.0380442933465, 6484.675766211671, 6487.545871788977, 6494.415502604741, 6968.372846443743, 6978.79063628092, 7017.578945263301, 7085.397741192057, 7213.531120477152, 6691.799246022627, 6766.221884483249, 6784.287649796799, 6789.25318214996, 6848.931510684829, 6936.895946560705, 6994.195667498201, 7001.054857594261, 7016.0, 7021.192562855234, 6869.622170780655, 6892.448604111759, 6944.861102777916, 6972.442204623618, 6973.12835895513, 6744.730210791513, 6827.897581536281, 6862.519623626298, 6884.036234927014, 6915.308469153045, 5081.872953176126, 5088.77100530477, 5102.872428189325, 5103.030424219386, 5107.438181799999, 4458.665600080007, 4530.388397566352, 4547.181507328646, 4596.310553416947, 4642.767861606906, 6263.812085637438, 6321.399467050623, 6344.873102537924, 6345.777897773556, 6346.460550853137, 6838.794836154923, 6840.213375461786, 6923.030775691407, 6925.376716095576, 6949.166100068024, 6202.0, 6239.220097487814, 6239.500839932794, 6270.028145637433, 6280.7487700491465, 5469.316335458067, 5504.174373843955, 5547.306586676666, 5550.417206193291, 5559.332880054339, 7076.752313668997, 7100.822479437952, 7162.534435261691, 7165.749198778018, 7181.0, 6711.261761206166, 6723.697433615401, 6799.93200067993, 6855.794326170223, 6899.862002759816, 7049.859002820018, 7110.5022648414115, 7112.395446387115, 7168.713251469882, 7248.746293879689, 6895.6552172392185, 6898.413634840894, 6898.482613804085, 6901.1718593769065, 6902.965485172743, 6832.624205668736, 6840.589564626139, 6899.379055884994, 6909.0, 6921.1002569667635, 6555.115059466911, 6683.933160668331, 6687.598744075371, 6706.362895524917, 6781.38967492928, 6554.115194448688, 6671.299513551007, 6680.5323627345615, 6701.698423571049, 6731.697073631796, 6466.741330346734, 6521.054447105238, 6528.118703974903, 6553.279139294578, 6559.344065593403, 6612.206535215805, 6680.365365290289, 6724.529282950147, 6745.561538499982, 6758.053872457958, 6368.076628888878, 6395.488360931207, 6477.287498375269, 6490.350964903472, 6567.343265673395], "value": 6277.021343717005, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [894.843402404579, 965.8502932045533, 984.8227319082562, 987.2990176974353, 995.6515219673113, 46530.534694653084, 47197.0560588788, 47411.051778964444, 47412.28881566771, 47431.525684743145, 44326.33510497345, 44348.0, 44358.778206109004, 44383.0, 44543.331850022194, 7521.924780752191, 7587.696492140308, 7601.619919004055, 7612.276833700789, 7613.276738709814, 7700.845983080363, 7741.845163096763, 7799.2590703883325, 7818.569978651172, 7839.804004899866, 8344.165583441638, 8603.44077634955, 8609.39734218605, 8618.78453038676, 8623.913760862373, 8488.872666910001, 8512.74461766148, 8518.87221691675, 8568.357373197035, 8575.656973721043, 8152.225538573826, 8380.958095209546, 8401.075881653012, 8468.66125354985, 8571.271441927443, 43277.783611081744, 43760.562394375964, 43824.780876095734, 43834.342484862755, 43844.0, 3747.5502939647145, 3759.812009399519, 3781.7920014399197, 3805.0867791729784, 3807.1814559869485, 33982.0, 34132.48801267983, 34186.48720269173, 34219.6578034219, 34240.315193695984, 5518.779248830042, 5533.557315414798, 5540.556755459594, 5555.861103472405, 5559.19391688207, 225438.0, 228874.0, 230132.0, 230183.0, 231091.0, 48455.515444845805, 48882.75558622255, 55915.0, 56560.43439565552, 56584.71707641435, 58911.41088589145, 58937.70531147317, 58954.41045589575, 58986.705066474395, 59013.11480327798, 17176.141192940304, 17403.129843507773, 17419.0, 17448.0, 17467.56331091733, 14090.225037622824, 14307.141571505743, 14311.713765724835, 14315.212663303619, 14340.498082567061, 15486.22568871552, 15496.52276800648, 15582.9220853895, 15589.922050389676, 15593.376264949502, 5941.970290148608, 6088.056351265561, 6138.974138534273, 6192.195014648067, 6192.473639740582, 1099.631623406152, 1103.172620534599, 1103.7351035751522, 1107.7175320293275, 1122.3434290939729, 26333.736662633513, 26340.473190536082, 26580.734192658212, 26624.334391640365, 27047.86476067607, 1214.495984166561, 1221.0780860450302, 1241.1312081542956, 1241.7081985733346, 1244.5270797097226, 13661.658458538417, 13743.656408589864, 13824.792628110587, 14059.648508787157, 14190.432382704783, 279339.0, 296841.0, 304516.0, 307744.0, 308082.0, 62376.376236237054, 62485.0, 62709.68645156745, 62729.68635156795, 63055.0, 1545.1964978211493, 1561.664242187935, 1568.929398177062, 1570.6151992761847, 1570.9214539272991, 26189.083382081535, 26300.8684956574, 26344.8682756585, 26482.735172648026, 26562.46875062449, 43837.34243986279, 43891.56108438875, 43915.78042109769, 43990.0, 44085.77957110194, 181696.0, 182364.0, 182396.0, 182652.0, 182755.0, 38232.808835956756, 40700.796496017334, 41204.38193427161, 41274.0, 41487.1702565953, 53029.7348513255, 53917.460825392816, 54157.72921135527, 54490.72754636202, 54541.72729136329, 38748.0, 38876.80561597174, 39025.21949560936, 39198.41202382024, 39395.40906886342, 38170.0, 38253.234935300585, 38328.42507362336, 38459.42310865283, 38647.22705545817, 44055.33916991312, 45388.0, 45402.0, 45955.54044459513, 46008.769956150005, 33093.33813323768, 33148.0, 33356.332873342886, 33432.498512521845, 33506.329873401904, 27840.44319113647, 28007.299817504725, 28133.57799633048, 28301.57547636746, 28386.574201387408], "value": 19239.521493453914, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [603.6649659439009, 612.8631388773824, 625.6871564217892, 626.8307556959621, 643.1703102997134, 23777.881110594466, 23876.164334248304, 24468.632970505456, 24532.141375051877, 24582.877085614593, 25042.749572504268, 25976.35059123523, 26027.219183424528, 26044.0, 26055.60916586248, 6537.80386588402, 6616.106825578558, 6682.99755036746, 6684.298148694365, 6689.799306020803, 6364.84087897804, 6608.70260838261, 6691.665416729168, 6740.258571557125, 6742.797716068526, 6684.29814869439, 6692.431143352821, 6698.83252918676, 6698.8995165072565, 6702.497312701543, 6421.036844473319, 6658.167729033871, 6666.566673166253, 6687.431568316674, 6709.09427227323, 6300.779472718433, 6301.180846489973, 6301.369863013708, 6304.27500837405, 6308.936910630927, 29697.851510742523, 29837.25406864824, 30094.699053009626, 30181.245468863235, 30209.0, 2270.0465804362207, 2297.425643589103, 2304.83866129371, 2311.318161142467, 2311.3759284992957, 19360.903195483934, 19652.70520942187, 19885.20459181631, 19904.303349382702, 20441.0, 2542.351700316426, 2551.8596477193746, 2626.4090579619624, 2667.1331817159503, 2696.4472283182095, 137629.0, 143739.0, 161500.0, 168251.0, 170009.14995424944, 16133.677326453406, 16156.596085097966, 16281.51155465338, 16628.750568741478, 16668.833311666727, 26306.47387052248, 26415.867920660272, 26484.0, 26497.205083847515, 26519.0, 10610.257281990187, 10654.946725266323, 10669.679909602724, 10924.672259832218, 10936.726581835517, 9547.952260238655, 9611.951940240393, 9654.131128198356, 9814.558344874498, 9818.26363022776, 10008.599656013677, 10036.146927511243, 10057.497125143713, 10261.58953641846, 10264.794704106025, 3099.930523969227, 3108.207407111172, 3122.281875168724, 3124.671909449475, 3211.0, 1050.6165249683963, 1063.4576366053368, 1072.8927107289364, 1078.6224821312478, 1081.4376524207369, 20676.689849652266, 21258.468538286357, 21390.144394224368, 21486.677699834516, 21697.132114715234, 1109.3011402816335, 1110.8555887734542, 1115.275071203724, 1117.9217454778088, 1121.4560937945091, 11608.419579021016, 11749.588764393206, 11757.706057348634, 11761.176717629683, 11889.286642801286, 618796.0, 628868.0, 632709.0, 637448.0, 666185.0, 134676.0, 135901.0, 137241.0, 139203.0, 140486.29756851355, 1133.5239199536215, 1179.215821478707, 1237.7276999060193, 1252.248650809507, 1293.1529847949796, 21682.2411215613, 22121.889390552944, 22122.225722100295, 22277.77722222822, 22287.0, 63694.36305636884, 63726.362736372044, 63920.680396597716, 65401.67299163474, 65949.0, 82190.17809822064, 82451.0, 82847.0, 82962.17037829544, 85762.57118714367, 15672.451464198699, 15941.0, 15983.28075236594, 15995.440159594358, 16126.838731612534, 24226.75773242245, 24425.26724198277, 24462.510749785262, 24699.382515437257, 24756.50486990214, 19619.803801961796, 19837.30569430063, 19850.50373740668, 19938.102785374984, 20222.494437638587, 17145.31418743286, 17152.828471715122, 17159.485215443558, 17309.134543272536, 17519.124043798012, 19532.414027579194, 20500.17999280012, 20553.691694624293, 20592.485187870425, 20725.68911466299, 15562.533124006299, 15615.687686246438, 15716.842831571537, 15731.292091856123, 15750.0, 19638.410847674593, 19803.801961980196, 19888.801111988694, 20021.59956800885, 20111.0], "value": 12995.103467125276, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1462.0935020287423, 1520.2246854104403, 1529.1054732981206, 1544.3050627217751, 1547.4274518428183, 17012.40456584018, 17656.0, 17696.20367083481, 17721.64556708865, 17731.0, 17224.311027558913, 17284.740728889046, 17298.481045568653, 17347.0, 17401.564960875985, 2806.6912639609627, 2867.641544806899, 2874.9712502874913, 2888.4078763853463, 2902.9129126126145, 2628.316637674209, 2628.6976997645324, 2631.473705258946, 2633.1573896353175, 2636.1696065739325, 2720.5511090670016, 2779.8749056292513, 2780.2215379693616, 2781.068342105387, 2781.4576157649267, 2726.4138210284787, 2762.9447411051665, 2763.9447211055767, 2764.1845655531665, 2767.501849667059, 2681.4313626528506, 2713.2945434187054, 2715.6876959149554, 2716.9592456113173, 2718.1573712149298, 16643.41748038813, 16746.581335466588, 16798.58003549909, 16880.409185678443, 16953.491395258163, 8135.918640813635, 8524.78688032798, 8535.914640853574, 8540.103289154611, 8548.78628034298, 5035.370578677665, 5325.946740532584, 5478.205660179252, 5503.422140675211, 5631.324241091054, 2001.6597178479694, 2052.322733497942, 2068.6896965455153, 2100.5168811173517, 2101.6006958677954, 27227.183184504498, 28292.15123546297, 30847.69152308493, 31750.523742143887, 31814.0, 7924.762257132295, 8027.397945154137, 8029.638666259915, 8170.305524030524, 8257.504549727035, 23487.060517579106, 23508.059677613044, 23551.528969420517, 23558.882205588863, 23670.526589468114, 8701.738947831574, 8784.868226976601, 8810.074942131112, 8841.469511829311, 8845.734627961172, 7585.127710313274, 7941.483803552751, 8150.3479721622125, 8215.917840821634, 8222.17778222173, 6168.444839964424, 6193.256809182927, 6228.377162283736, 6278.748850045947, 6297.779577714758, 1953.64834329822, 1957.6182644384494, 1966.7934866839062, 1967.7737060238255, 1968.724378586999, 926.7590426489027, 940.1397721085131, 949.8860136783492, 950.5959967013991, 953.2564599612314, 8839.248663863515, 8922.107789221156, 8933.46399216049, 9017.909820901707, 9039.412438191497, 797.2266901105918, 799.1050023973187, 802.3260461212609, 802.9598520073973, 813.9145389734111, 5115.641905066684, 5147.794088236504, 5218.765155568009, 5232.633715639945, 5240.292560504283, 24745.133920313063, 25488.0, 25626.103086391886, 25888.74111258901, 25913.740862591134, 24371.878140609184, 25217.74782252154, 25307.873460632578, 25419.0, 25489.0, 10599.205059620559, 10981.17641176915, 11451.828222576669, 11915.52337906474, 12067.818982715266, 9414.435133891988, 9510.667126650535, 9637.855432168662, 9638.0, 9813.11681948628, 21498.892505538, 21543.0, 21602.919854007552, 21718.891405542872, 22573.887130564242, 22061.22785702557, 22611.0, 22751.772482274966, 23081.422964426023, 23365.649515256944, 13281.40233689467, 13328.866711332763, 13384.063115582205, 13390.26353550564, 13489.730205396034, 15170.544883653509, 15296.464623738117, 15314.0, 15316.081035137928, 15322.616934576725, 12253.69365765863, 12465.5013799447, 12505.624831255076, 12574.811377829157, 12659.620211393672, 12261.141720079866, 12459.252444853339, 12536.247825130522, 12589.93705031469, 12610.558630448257, 10007.249456290952, 10148.086672199537, 10148.188144948534, 10158.13655839262, 10163.796724065625, 8155.8192305002285, 8257.628406721831, 8320.625571849161, 8382.16178382157, 8421.07368189511, 7800.531968081933, 7898.565578893216, 7917.841643167219, 7971.561564114029, 7995.920040799518], "value": 7341.869528199737, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.4695266020952, 571.65414923971, 574.5432381256902, 583.2592607388614, 594.5837913460579, 6101.176341193937, 6258.937410625898, 6335.588186767863, 6356.968215158918, 6357.71390287437, 6113.266408031042, 6197.0, 6233.189685340899, 6264.686765661721, 6309.990401535755, 5070.72111033893, 5099.694018358892, 5106.897862042757, 5107.4892510749, 5114.335136432259, 4877.561019508244, 4987.127252730757, 5013.470891378128, 5030.396352437712, 5037.3451451311275, 4947.529984651453, 4958.504149585031, 4965.155923492996, 4980.8544034872, 4983.950160498385, 4917.950820491785, 4942.382202224704, 4942.6293028022865, 4951.356323677935, 4966.553010229097, 4517.390152329459, 4580.106879158566, 4609.331646911179, 4609.400777898852, 4622.306654001893, 6206.751729930797, 6232.563720539564, 6243.282022567418, 6265.71804268809, 6267.905981410283, 5835.591508594358, 5858.0, 5895.233619629464, 5914.556408269354, 5935.584509084366, 6626.536142470029, 6657.966710166466, 6665.833354166136, 6678.43233325168, 6703.396694297488, 4900.509949005107, 5135.6918584885025, 5139.794408223666, 5151.304573882516, 5156.407013193493, 6666.100161453963, 6798.592084474898, 6813.4208592269715, 6890.345417185359, 6945.236024037352, 5241.764120614582, 5268.130758424893, 5296.841094767163, 5302.337207848942, 5305.65513241638, 5308.469153084738, 5334.279872217278, 5344.599155063386, 5356.062689029404, 5361.651492652965, 5931.7923872665115, 5955.255593050869, 5957.940420595825, 5969.641821490724, 5987.161797348288, 6493.285738568754, 6634.635095069721, 6642.900356494656, 6645.3022432643875, 6673.399394054559, 1805.9006754628358, 1836.7704036995376, 1836.8163183681793, 1839.567701590152, 1853.6014756827346, 1289.8710128987027, 1311.8688131186805, 1325.8143859859626, 1336.7527007503643, 1339.9280575539724, 5965.494492313239, 6005.927954855568, 6041.607295525777, 6066.211392519032, 6104.938950610526, 6662.6668666566475, 6693.364130407604, 6709.664516774142, 6768.187817461936, 6777.0, 6030.0, 6047.848803779941, 6094.75620975156, 6130.2030736004035, 6136.938630613637, 3522.260325331658, 3526.8765593204116, 3537.363274610595, 3548.538689970287, 3555.520004799319, 6810.353016463428, 6904.791661459224, 6925.272846351161, 6960.86760957561, 6978.0, 6720.227173875067, 6791.966040169767, 6857.142857142857, 6873.4157596603845, 6919.688614012382, 6957.156353566309, 7014.894776578355, 7020.192677842114, 7067.752628657972, 7091.368985133448, 6738.764143254963, 6741.359570840762, 6774.593524388552, 6776.051352810512, 6776.45788336922, 6634.83412914681, 6679.165104361955, 6780.355866192704, 6783.491238157059, 6794.3545363190415, 6937.306269373023, 6944.4444444445335, 7016.298370162943, 7069.328413800887, 7073.186583542958, 5231.398389185292, 5284.810917543522, 5301.455301455246, 5309.734513274244, 5310.601704872227, 6773.89839152423, 6838.589684618939, 6848.863022739617, 6887.552309099892, 6947.861042779015, 6554.705038273194, 6585.6377899216, 6607.141071660653, 6642.269350371359, 6652.866942661023, 6526.738930442919, 6532.542722009413, 6545.934540654723, 6547.0, 6610.8016759497295, 6394.808155755335, 6410.61536307823, 6438.098666186644, 6468.126802881551, 6480.57876238043, 6605.0, 6616.172978377703, 6618.933810662024, 6656.134702488645, 6688.765893193715, 6117.52481529038, 6319.273283572448, 6374.840628984312, 6378.202724659418, 6383.265924418752], "value": 5196.654971624173, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [936.9203617692496, 952.3428834104467, 989.2036910287216, 992.4045572656407, 1011.8128146292934, 20022.29921952732, 20037.799622003775, 20136.597268054647, 20350.898245508753, 20463.897680511596, 18695.158717857696, 18969.0, 19000.809991900078, 19301.227950881985, 19583.412497625057, 1035.2856528995007, 1051.0698032241482, 1052.9894701053006, 1056.0, 1056.2183983851933, 1038.870141232346, 1067.359584249448, 1068.177503322445, 1072.2815713471994, 1074.2265568790458, 1126.3185772607578, 1128.4527004402898, 1129.0008342616802, 1129.7571022230218, 1131.1516362727955, 1118.3513562133983, 1125.6679279612533, 1129.728865072385, 1131.5869707556765, 1131.773645270945, 786.9331106855867, 808.745245247751, 818.5661599352353, 818.7625588579305, 831.717216146507, 19534.12096455649, 19668.213271469125, 19966.401007969784, 19993.200271989248, 19999.10004049821, 22306.88846555773, 22326.888365558232, 23019.1943281986, 23083.307500775005, 23263.53472930532, 18543.165557549943, 18765.34321298748, 18869.716954245698, 18874.52813679655, 18901.33845315421, 3900.102976315435, 3933.6263055009726, 3937.153511994935, 3937.3700207966876, 3937.409388591734, 169901.0, 170387.0, 170582.0, 171087.0, 175618.99999999872, 16835.32658693663, 17520.21159047846, 17533.473995780147, 17804.3768468103, 17981.190846411944, 31140.065798026095, 31198.84400578028, 31220.0, 31452.84273578663, 31887.20281992922, 8978.281737460988, 9061.320400969953, 9063.728088157366, 9075.909240907638, 9088.500132492776, 4668.4631267404, 4686.086213188396, 4766.95233047672, 4771.165046116916, 4784.425868895755, 6009.729562169713, 6226.40849119333, 6226.6575338355915, 6229.875402491924, 6256.092866534327, 1032.3650954662828, 1045.4929359260752, 1059.7880423915249, 1064.180580952662, 1078.2021304234809, 713.9607321597258, 724.5906063074347, 727.1819203396179, 740.7148247924588, 756.7729681095649, 12523.812142817866, 12526.801377428264, 12756.043296752781, 12913.225206487641, 13279.867201328056, 702.3152426384337, 703.714995426853, 710.6304721544768, 712.7149140343904, 727.1383410658386, 5995.910061349084, 6063.151158837766, 6216.316205217422, 6246.906296405557, 6250.281217660027, 158628.0, 158996.0, 162166.0, 164367.0, 166891.0, 144234.0, 145466.0, 145628.27185864002, 146893.0, 148320.0, 119887.40056299837, 122744.0, 122763.38618306852, 122992.0, 126425.0, 11587.420628968686, 11622.012128969132, 11691.649250522498, 11715.1799374043, 11816.76366472683, 56470.435295646515, 57024.71487642535, 57320.14019789623, 57882.710586446796, 58072.709636451546, 77127.61436192783, 78420.60789696015, 79301.20698792938, 79435.0, 80336.59831700804, 15872.127033013296, 16142.273597687898, 16274.593135171715, 16355.0, 16396.0, 19314.613707726046, 19614.0, 19625.70561441608, 19781.307654232034, 19787.901060494605, 16432.917835410746, 16565.25456354443, 16614.086225257728, 16724.080175590458, 16863.578410539834, 17863.553411164823, 18214.635707285513, 18248.270069197082, 18353.72469412933, 18518.0740962954, 17186.484405467854, 17249.91375043117, 17287.654246915245, 17311.65376692434, 17488.73766893523, 11468.483918223534, 11889.405529723652, 11899.167058306182, 12205.0, 12380.62858114258, 12474.563390281297, 12497.18768280059, 12535.185212961129, 12593.811092833432, 12791.808122877977], "value": 9867.038155288094, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1362.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 104.0, 105.0, 104.0, 107.0, 108.0, 106.0, 105.0, 104.0, 103.0], "value": 105.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 116.0, 112.0, 111.0, 113.0, 111.0, 113.0, 144.0, 113.0, 114.0], "value": 115.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 163.0, 161.0, 161.0, 162.0, 161.0, 162.0, 161.0, 167.0], "value": 162.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 72.0, 73.0, 73.0, 73.0, 75.0, 73.0, 73.0, 74.0], "value": 73.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 79.0, 79.0, 77.0, 77.0, 80.0, 77.0, 77.0, 78.0, 79.0], "value": 79.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 114.0, 115.0, 113.0, 114.0, 114.0, 113.0, 114.0, 113.0, 115.0], "value": 113.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 150.0, 150.0, 149.0, 148.0, 149.0, 150.0, 149.0, 150.0, 150.0], "value": 149.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 98.0, 94.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 94.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [45.0, 45.0, 44.0, 50.0, 44.0, 44.0, 43.0, 46.0, 46.0, 43.0], "value": 45.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [36.0, 35.0, 37.0, 36.0, 36.0, 36.0, 36.0, 36.0, 35.0, 36.0], "value": 35.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 69.0, 69.0, 70.0, 70.0, 70.0, 66.0, 76.0, 71.0], "value": 70.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 103.0, 102.0, 106.0, 109.0, 106.0, 115.0, 108.0, 107.0, 102.0], "value": 106.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 150.0, 147.0, 149.0, 147.0, 145.0, 145.0, 150.0, 147.0, 148.0], "value": 149.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 59.0, 62.0, 65.0, 64.0, 66.0, 59.0, 60.0, 67.0], "value": 62.0, "unit": "score"}]}]} 04:32:54 INFO - Return code: 0 04:32:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:32:54 INFO - # TBPL SUCCESS # 04:32:54 INFO - Running post-action listener: _package_coverage_data 04:32:54 INFO - Running post-action listener: _resource_record_post_action 04:32:54 INFO - [mozharness: 2017-10-03 11:32:54.803763Z] Finished run-tests step (success) 04:32:54 INFO - Running post-run listener: _resource_record_post_run 04:32:54 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 330088448; Read time: 8; Write time: 205504 04:32:54 INFO - TinderboxPrint: CPU usage
13.1% 04:32:54 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 04:32:54 INFO - TinderboxPrint: I/O write bytes / time
330,088,448 / 205,504 04:32:54 INFO - TinderboxPrint: CPU idle
8,211.0 (86.9%) 04:32:54 INFO - TinderboxPrint: CPU user
1,187.9 (12.6%) 04:32:54 INFO - TinderboxPrint: Swap in / out
0 / 0 04:32:54 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 13369344; Read time: 0; Write time: 1984 04:32:54 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 04:32:54 INFO - run-tests - Wall time: 1167s; CPU: 13.0%; Read bytes: 0; Write bytes: 316186624; Read time: 0; Write time: 203440 04:32:55 INFO - Running post-run listener: _upload_blobber_files 04:32:55 INFO - Blob upload gear active. 04:32:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:32:55 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 04:32:55 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'] 04:32:55 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 04:32:56 INFO - (blobuploader) - INFO - Open directory for files ... 04:32:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 04:32:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:32:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:32:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 04:32:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:32:57 INFO - (blobuploader) - INFO - Done attempting. 04:32:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:32:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:32:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:33:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:33:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:33:12 INFO - (blobuploader) - INFO - Done attempting. 04:33:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:33:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:33:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:33:13 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:33:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:33:13 INFO - (blobuploader) - INFO - Done attempting. 04:33:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 04:33:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:33:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:33:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 04:33:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:33:15 INFO - (blobuploader) - INFO - Done attempting. 04:33:15 INFO - (blobuploader) - INFO - Iteration through files over. 04:33:15 INFO - Return code: 0 04:33:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:33:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:33:15 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/66e9e951a5e79e774e58d5b9b2403875dd533157549ae4fc3528a937da495a8b801ca370880e455184ba7c1c812f0901bb32554efbd9152a974a83066a3b1ca9", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/43ec452a0a9c30bf8d53548b6686cdf61ccaa1ed3c475257c5d83d6bbcb5a585580034f53159e7b064e68586656843668671e54c5242f86d91faaefb724819da", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/904296ee55e81f2988b627c01b704671cc8680f5036222ea31920e4b7b227c685ff9db525c7ec746ad033d86e0af23cbdcc68e250104328013e59f714923be89", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b34a7c1826f1734bcd6180f351e6efee67e8e091b26b075c214fe3a2c35c9616ff3ce2eaad67f6c77e3dac27a509e52ea98e9d7385fdb9d84d53db3ac076e358"} 04:33:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:33:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:33:15 INFO - Contents: 04:33:15 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/66e9e951a5e79e774e58d5b9b2403875dd533157549ae4fc3528a937da495a8b801ca370880e455184ba7c1c812f0901bb32554efbd9152a974a83066a3b1ca9", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/43ec452a0a9c30bf8d53548b6686cdf61ccaa1ed3c475257c5d83d6bbcb5a585580034f53159e7b064e68586656843668671e54c5242f86d91faaefb724819da", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/904296ee55e81f2988b627c01b704671cc8680f5036222ea31920e4b7b227c685ff9db525c7ec746ad033d86e0af23cbdcc68e250104328013e59f714923be89", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b34a7c1826f1734bcd6180f351e6efee67e8e091b26b075c214fe3a2c35c9616ff3ce2eaad67f6c77e3dac27a509e52ea98e9d7385fdb9d84d53db3ac076e358"} 04:33:15 INFO - Running post-run listener: copy_logs_to_upload_dir 04:33:15 INFO - Copying logs to upload dir... 04:33:15 INFO - mkdir: /builds/slave/test/build/upload/logs 04:33:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.419117 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2017-10-03 04:33:15.133158) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-03 04:33:15.136209) ========= 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=9531f05ccb2eabcb9acf5f1b000001c0-1507029044.924251-868986532 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/66e9e951a5e79e774e58d5b9b2403875dd533157549ae4fc3528a937da495a8b801ca370880e455184ba7c1c812f0901bb32554efbd9152a974a83066a3b1ca9", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/43ec452a0a9c30bf8d53548b6686cdf61ccaa1ed3c475257c5d83d6bbcb5a585580034f53159e7b064e68586656843668671e54c5242f86d91faaefb724819da", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/904296ee55e81f2988b627c01b704671cc8680f5036222ea31920e4b7b227c685ff9db525c7ec746ad033d86e0af23cbdcc68e250104328013e59f714923be89", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b34a7c1826f1734bcd6180f351e6efee67e8e091b26b075c214fe3a2c35c9616ff3ce2eaad67f6c77e3dac27a509e52ea98e9d7385fdb9d84d53db3ac076e358"} build_url:https://queue.taskcluster.net/v1/task/HK3Cnu3ZQ2u3dGHBaXWQPg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011468 build_url: 'https://queue.taskcluster.net/v1/task/HK3Cnu3ZQ2u3dGHBaXWQPg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/66e9e951a5e79e774e58d5b9b2403875dd533157549ae4fc3528a937da495a8b801ca370880e455184ba7c1c812f0901bb32554efbd9152a974a83066a3b1ca9", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/43ec452a0a9c30bf8d53548b6686cdf61ccaa1ed3c475257c5d83d6bbcb5a585580034f53159e7b064e68586656843668671e54c5242f86d91faaefb724819da", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/904296ee55e81f2988b627c01b704671cc8680f5036222ea31920e4b7b227c685ff9db525c7ec746ad033d86e0af23cbdcc68e250104328013e59f714923be89", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b34a7c1826f1734bcd6180f351e6efee67e8e091b26b075c214fe3a2c35c9616ff3ce2eaad67f6c77e3dac27a509e52ea98e9d7385fdb9d84d53db3ac076e358"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-03 04:33:15.164535) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-03 04:33:15.164845) ========= 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=9531f05ccb2eabcb9acf5f1b000001c0-1507029044.924251-868986532 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004483 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-03 04:33:15.249836) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-03 04:33:15.250141) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-03 04:33:15.250445) ========= ========= Total master_lag: 0.19 =========