builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-075 starttime: 1504049364.47 results: success (0) revision: 8f221407c6006ac1de529da77ecc18431dde3e99 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-29 16:29:24.471196) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-29 16:29:24.471628) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-29 16:29:24.471917) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-29 16:29:24.527449) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-29 16:29:24.527726) ========= 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=fcadb68e09dcf59683000ff6000001dc-1504042539.837449-895384914 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-29 16:29:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 227M=0s 2017-08-29 16:29:24 (227 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.152974 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-29 16:29:24.695428) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-29 16:29:24.695721) ========= 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=fcadb68e09dcf59683000ff6000001dc-1504042539.837449-895384914 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021369 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-29 16:29:24.747904) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-29 16:29:24.751250) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8f221407c6006ac1de529da77ecc18431dde3e99 --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 8f221407c6006ac1de529da77ecc18431dde3e99 --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=fcadb68e09dcf59683000ff6000001dc-1504042539.837449-895384914 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-29 16:29:24,932 truncating revision to first 12 chars 2017-08-29 16:29:24,932 Setting DEBUG logging. 2017-08-29 16:29:24,932 attempt 1/10 2017-08-29 16:29:24,932 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8f221407c600?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-29 16:29:25,227 unpacking tar archive at: mozilla-central-8f221407c600/testing/mozharness/ program finished with exit code 0 elapsedTime=0.619160 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-29 16:29:25.384944) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-29 16:29:25.388262) ========= script_repo_revision: 8f221407c6006ac1de529da77ecc18431dde3e99 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-29 16:29:25.388632) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-29 16:29:25.388891) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-29 16:29:25.400800) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-08-29 16:29:25.401089) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fcadb68e09dcf59683000ff6000001dc-1504042539.837449-895384914 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:29:25 INFO - MultiFileLogger online at 20170829 16:29:25 in /builds/slave/test 16:29:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 16:29:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:29:25 INFO - {'append_to_log': False, 16:29:25 INFO - 'base_work_dir': '/builds/slave/test', 16:29:25 INFO - 'blob_upload_branch': 'Firefox', 16:29:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:29:25 INFO - 'branch': 'Firefox', 16:29:25 INFO - 'buildbot_json_path': 'buildprops.json', 16:29:25 INFO - 'code_coverage': False, 16:29:25 INFO - 'config_files': ('talos/linux_config.py',), 16:29:25 INFO - 'default_actions': ('clobber', 16:29:25 INFO - 'read-buildbot-config', 16:29:25 INFO - 'download-and-extract', 16:29:25 INFO - 'populate-webroot', 16:29:25 INFO - 'create-virtualenv', 16:29:25 INFO - 'install', 16:29:25 INFO - 'setup-mitmproxy', 16:29:25 INFO - 'run-tests'), 16:29:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:29:25 INFO - 'disable_ccov_upload': False, 16:29:25 INFO - 'disable_stylo': False, 16:29:25 INFO - 'download_minidump_stackwalk': True, 16:29:25 INFO - 'download_symbols': 'ondemand', 16:29:25 INFO - 'enable_stylo': False, 16:29:25 INFO - 'enable_webrender': False, 16:29:25 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 16:29:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:29:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:29:25 INFO - 'gecko_profile': False, 16:29:25 INFO - 'gecko_profile_interval': 0, 16:29:25 INFO - 'installer_path': 'installer.exe', 16:29:25 INFO - 'log_level': 'info', 16:29:25 INFO - 'log_name': 'talos', 16:29:25 INFO - 'log_to_console': True, 16:29:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:29:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:29:25 INFO - 'opt_config_files': (), 16:29:25 INFO - 'pip_index': False, 16:29:25 INFO - 'suite': 'dromaeojs-e10s', 16:29:25 INFO - 'system_bits': '32', 16:29:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:29:25 INFO - 'title': 'talos-linux64-ix-075', 16:29:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:29:25 INFO - 'use_talos_json': True, 16:29:25 INFO - 'verify': 'False', 16:29:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:29:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:29:25 INFO - 'work_dir': 'build'} 16:29:25 INFO - [mozharness: 2017-08-29 23:29:25.729056Z] Running clobber step. 16:29:25 INFO - Running pre-action listener: _resource_record_pre_action 16:29:25 INFO - Running main action method: clobber 16:29:25 INFO - rmtree: /builds/slave/test/build 16:29:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:29:27 INFO - Running post-action listener: _resource_record_post_action 16:29:27 INFO - [mozharness: 2017-08-29 23:29:27.259635Z] Finished clobber step (success) 16:29:27 INFO - [mozharness: 2017-08-29 23:29:27.259732Z] Running read-buildbot-config step. 16:29:27 INFO - Running pre-action listener: _resource_record_pre_action 16:29:27 INFO - Running main action method: read_buildbot_config 16:29:27 INFO - Using buildbot properties: 16:29:27 INFO - { 16:29:27 INFO - "project": "", 16:29:27 INFO - "product": "firefox", 16:29:27 INFO - "who": "kwierso@gmail.com", 16:29:27 INFO - "installer_path": "public/build/target.tar.bz2", 16:29:27 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 16:29:27 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 16:29:27 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 16:29:27 INFO - "stage_platform": "linux64-qr", 16:29:27 INFO - "basedir": "/builds/slave/test", 16:29:27 INFO - "buildnumber": 23, 16:29:27 INFO - "platform": "ubuntu64_hw_qr", 16:29:27 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:29:27 INFO - "slavebuilddir": "test", 16:29:27 INFO - "taskId": "NqOmBm4KTyuR73UTdLDsdA", 16:29:27 INFO - "branch": "mozilla-central", 16:29:27 INFO - "script_repo_revision": "production", 16:29:27 INFO - "revision": "8f221407c6006ac1de529da77ecc18431dde3e99", 16:29:27 INFO - "slavename": "talos-linux64-ix-075", 16:29:27 INFO - "repo_path": "mozilla-central" 16:29:27 INFO - } 16:29:27 INFO - Finding installer, test and symbols from parent task. 16:29:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NqOmBm4KTyuR73UTdLDsdA'}, attempt #1 16:29:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NqOmBm4KTyuR73UTdLDsdA'}, attempt #1 16:29:28 INFO - Task dependencies: OLOX1rRMRjiLLTkG5J30Ew 16:29:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OLOX1rRMRjiLLTkG5J30Ew'}, attempt #1 16:29:28 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/OLOX1rRMRjiLLTkG5J30Ew/artifacts/public/build/target.tar.bz2 16:29:28 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/OLOX1rRMRjiLLTkG5J30Ew/artifacts/public/build/target.test_packages.json 16:29:28 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/OLOX1rRMRjiLLTkG5J30Ew/artifacts/public/build/target.crashreporter-symbols.zip 16:29:28 INFO - Running post-action listener: _resource_record_post_action 16:29:28 INFO - [mozharness: 2017-08-29 23:29:28.605351Z] Finished read-buildbot-config step (success) 16:29:28 INFO - [mozharness: 2017-08-29 23:29:28.605567Z] Running download-and-extract step. 16:29:28 INFO - Running pre-action listener: _resource_record_pre_action 16:29:28 INFO - Running main action method: download_and_extract 16:29:28 INFO - mkdir: /builds/slave/test/build/tests 16:29:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:29:28 INFO - trying https://queue.taskcluster.net/v1/task/OLOX1rRMRjiLLTkG5J30Ew/artifacts/public/build/target.test_packages.json 16:29:28 INFO - Downloading https://queue.taskcluster.net/v1/task/OLOX1rRMRjiLLTkG5J30Ew/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:29:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OLOX1rRMRjiLLTkG5J30Ew/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:29:29 INFO - Downloaded 989 bytes. 16:29:29 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:29:29 INFO - Using the following test package requirements: 16:29:29 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 16:29:29 INFO - u'common': [u'target.common.tests.zip'], 16:29:29 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:29:29 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:29:29 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:29:29 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:29:29 INFO - u'mozbase': [u'target.common.tests.zip'], 16:29:29 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:29:29 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:29:29 INFO - u'web-platform': [u'target.common.tests.zip', 16:29:29 INFO - u'target.web-platform.tests.tar.gz'], 16:29:29 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:29:29 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 16:29:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OLOX1rRMRjiLLTkG5J30Ew/artifacts/public/build/target.common.tests.zip 16:29:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OLOX1rRMRjiLLTkG5J30Ew/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:29:29 INFO - Fetch https://queue.taskcluster.net/v1/task/OLOX1rRMRjiLLTkG5J30Ew/artifacts/public/build/target.common.tests.zip into memory 16:29:30 INFO - Content-Length response header: 54980876 16:29:30 INFO - Bytes received: 54980876 16:29:41 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 16:29:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OLOX1rRMRjiLLTkG5J30Ew/artifacts/public/build/target.common.tests.zip 16:29:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OLOX1rRMRjiLLTkG5J30Ew/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:29:41 INFO - Fetch https://queue.taskcluster.net/v1/task/OLOX1rRMRjiLLTkG5J30Ew/artifacts/public/build/target.common.tests.zip into memory 16:29:44 INFO - Content-Length response header: 54980876 16:29:44 INFO - Bytes received: 54980876 16:29:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OLOX1rRMRjiLLTkG5J30Ew/artifacts/public/build/target.talos.tests.zip 16:29:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OLOX1rRMRjiLLTkG5J30Ew/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:29:56 INFO - Fetch https://queue.taskcluster.net/v1/task/OLOX1rRMRjiLLTkG5J30Ew/artifacts/public/build/target.talos.tests.zip into memory 16:29:56 INFO - Content-Length response header: 14496610 16:29:56 INFO - Bytes received: 14496610 16:29:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:29:57 INFO - trying https://queue.taskcluster.net/v1/task/OLOX1rRMRjiLLTkG5J30Ew/artifacts/public/build/target.tar.bz2 16:29:57 INFO - Downloading https://queue.taskcluster.net/v1/task/OLOX1rRMRjiLLTkG5J30Ew/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:29:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OLOX1rRMRjiLLTkG5J30Ew/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:29:58 INFO - Downloaded 62574194 bytes. 16:29:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OLOX1rRMRjiLLTkG5J30Ew/artifacts/public/build/target.tar.bz2 16:29:58 INFO - mkdir: /builds/slave/test/properties 16:29:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:29:58 INFO - Writing to file /builds/slave/test/properties/build_url 16:29:58 INFO - Contents: 16:29:58 INFO - build_url:https://queue.taskcluster.net/v1/task/OLOX1rRMRjiLLTkG5J30Ew/artifacts/public/build/target.tar.bz2 16:29:58 INFO - Running post-action listener: _resource_record_post_action 16:29:58 INFO - Running post-action listener: find_tests_for_verification 16:29:58 INFO - Running post-action listener: set_extra_try_arguments 16:29:58 INFO - [mozharness: 2017-08-29 23:29:58.460731Z] Finished download-and-extract step (success) 16:29:58 INFO - [mozharness: 2017-08-29 23:29:58.460919Z] Running populate-webroot step. 16:29:58 INFO - Running pre-action listener: _resource_record_pre_action 16:29:58 INFO - Running main action method: populate_webroot 16:29:58 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:29:58 INFO - 'chromez-stylo-e10s': {'talos_options': ['--enable-stylo'], 16:29:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:29:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:29:58 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--enable-stylo'], 16:29:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:29:58 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:29:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:29:58 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 16:29:58 INFO - 'talos_options': ['--enable-stylo'], 16:29:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:29:58 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:29:58 INFO - 'tests': ['damp', 'tps']}, 16:29:58 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 16:29:58 INFO - 'talos_options': ['--enable-stylo'], 16:29:58 INFO - 'tests': ['damp', 'tps']}, 16:29:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:29:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 16:29:58 INFO - 'g4-stylo-e10s': {'talos_options': ['--enable-stylo'], 16:29:58 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 16:29:58 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 16:29:58 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 16:29:58 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 16:29:58 INFO - 'talos_options': ['--enable-stylo'], 16:29:58 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 16:29:58 INFO - 'other-e10s': {'tests': ['a11yr', 16:29:58 INFO - 'ts_paint', 16:29:58 INFO - 'tpaint', 16:29:58 INFO - 'sessionrestore', 16:29:58 INFO - 'sessionrestore_many_windows', 16:29:58 INFO - 'sessionrestore_no_auto_restore', 16:29:58 INFO - 'tabpaint']}, 16:29:58 INFO - 'other-stylo-e10s': {'talos_options': ['--enable-stylo'], 16:29:58 INFO - 'tests': ['a11yr', 16:29:58 INFO - 'ts_paint', 16:29:58 INFO - 'tpaint', 16:29:58 INFO - 'sessionrestore', 16:29:58 INFO - 'sessionrestore_many_windows', 16:29:58 INFO - 'sessionrestore_no_auto_restore', 16:29:58 INFO - 'tabpaint']}, 16:29:58 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 16:29:58 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 16:29:58 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--enable-stylo'], 16:29:58 INFO - 'tests': ['bloom_basic_singleton']}, 16:29:58 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--enable-stylo'], 16:29:58 INFO - 'tests': ['bloom_basic']}, 16:29:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:29:58 INFO - 'tsvgr_opacity', 16:29:58 INFO - 'tart', 16:29:58 INFO - 'tscrollx', 16:29:58 INFO - 'tsvg_static']}, 16:29:58 INFO - 'svgr-stylo-e10s': {'talos_options': ['--enable-stylo'], 16:29:58 INFO - 'tests': ['tsvgx', 16:29:58 INFO - 'tsvgr_opacity', 16:29:58 INFO - 'tart', 16:29:58 INFO - 'tscrollx', 16:29:58 INFO - 'tsvg_static']}, 16:29:58 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:29:58 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 16:29:58 INFO - 'talos_options': ['--enable-stylo'], 16:29:58 INFO - 'tests': ['tp5o']}, 16:29:58 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:29:58 INFO - 'talos_options': ['--mitmproxy', 16:29:58 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:29:58 INFO - '--firstNonBlankPaint'], 16:29:58 INFO - 'tests': ['tp6_google', 16:29:58 INFO - 'tp6_youtube', 16:29:58 INFO - 'tp6_amazon', 16:29:58 INFO - 'tp6_facebook']}, 16:29:58 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:29:58 INFO - 'talos_options': ['--enable-stylo', 16:29:58 INFO - '--mitmproxy', 16:29:58 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:29:58 INFO - '--firstNonBlankPaint'], 16:29:58 INFO - 'tests': ['tp6_google', 16:29:58 INFO - 'tp6_youtube', 16:29:58 INFO - 'tp6_amazon', 16:29:58 INFO - 'tp6_facebook']}, 16:29:58 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:29:58 INFO - 'talos_options': ['--enable-stylo', 16:29:58 INFO - '--stylo-threads=1', 16:29:58 INFO - '--mitmproxy', 16:29:58 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:29:58 INFO - '--firstNonBlankPaint'], 16:29:58 INFO - 'tests': ['tp6_google', 16:29:58 INFO - 'tp6_youtube', 16:29:58 INFO - 'tp6_amazon', 16:29:58 INFO - 'tp6_facebook']}, 16:29:58 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:29:58 INFO - 'talos_options': ['--xperf_path', 16:29:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:29:58 INFO - 'tests': ['tp5n']}, 16:29:58 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 16:29:58 INFO - 'talos_options': ['--enable-stylo', 16:29:58 INFO - '--xperf_path', 16:29:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:29:58 INFO - 'tests': ['tp5n']}}} 16:29:58 INFO - Running post-action listener: _resource_record_post_action 16:29:58 INFO - [mozharness: 2017-08-29 23:29:58.481257Z] Finished populate-webroot step (success) 16:29:58 INFO - [mozharness: 2017-08-29 23:29:58.481346Z] Running create-virtualenv step. 16:29:58 INFO - Running pre-action listener: _resource_record_pre_action 16:29:58 INFO - Running main action method: create_virtualenv 16:29:58 INFO - Creating virtualenv /builds/slave/test/build/venv 16:29:58 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:29:58 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 16:29:58 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 16:29:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:29:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:29:59 INFO - Installing distribute.............................................................................................................................................................................................done. 16:29:59 INFO - Installing pip...............done. 16:29:59 INFO - Return code: 0 16:29:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:29:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:29:59 INFO - Reading from file tmpfile_stdout 16:29:59 INFO - Output received: 16:29:59 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 16:29:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:29:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:29:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:29:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:29:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:29:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfdb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1347580>, '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 0x1348480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1348910>, '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': 'fcadb68e09dcf59683000ff6000001dc-1504042539.837449-895384914', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:29:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:29:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:29:59 INFO - Using env: {'DISPLAY': ':0', 16:29:59 INFO - 'HOME': '/home/cltbld', 16:29:59 INFO - 'LANG': 'en_US.UTF-8', 16:29:59 INFO - 'LANGUAGE': 'en_US:en', 16:29:59 INFO - 'LOGNAME': 'cltbld', 16:29:59 INFO - 'MAIL': '/var/mail/cltbld', 16:29:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:29:59 INFO - 'MOZ_NO_REMOTE': '1', 16:29:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:29:59 INFO - 'NO_EM_RESTART': '1', 16:29:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:29:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:29:59 INFO - 'PWD': '/builds/slave/test', 16:29:59 INFO - 'SHELL': '/bin/bash', 16:29:59 INFO - 'SHLVL': '1', 16:29:59 INFO - 'TERM': 'linux', 16:29:59 INFO - 'TMOUT': '86400', 16:29:59 INFO - 'USER': 'cltbld', 16:29:59 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1504042539.837449-895384914', 16:29:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:29:59 INFO - '_': '/tools/buildbot/bin/python'} 16:30:00 INFO - Ignoring indexes: http://pypi.python.org/simple/ 16:30:00 INFO - Downloading/unpacking pip>=1.5 16:30:00 INFO - Running setup.py egg_info for package pip 16:30:00 INFO - warning: no files found matching 'pip/cacert.pem' 16:30:00 INFO - warning: no files found matching '*.html' under directory 'docs' 16:30:00 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 16:30:00 INFO - no previously-included directories found matching 'docs/_build/_sources' 16:30:00 INFO - Installing collected packages: pip 16:30:00 INFO - Found existing installation: pip 1.1 16:30:00 INFO - Uninstalling pip: 16:30:00 INFO - Successfully uninstalled pip 16:30:00 INFO - Running setup.py install for pip 16:30:00 INFO - warning: no files found matching 'pip/cacert.pem' 16:30:00 INFO - warning: no files found matching '*.html' under directory 'docs' 16:30:00 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 16:30:00 INFO - no previously-included directories found matching 'docs/_build/_sources' 16:30:00 INFO - Installing pip script to /builds/slave/test/build/venv/bin 16:30:00 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 16:30:00 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 16:30:00 INFO - Successfully installed pip 16:30:00 INFO - Cleaning up... 16:30:00 INFO - Return code: 0 16:30:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:30:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:30:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:30:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:30:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:30:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xfdb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1347580>, '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 0x1348480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1348910>, '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': 'fcadb68e09dcf59683000ff6000001dc-1504042539.837449-895384914', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:30:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 16:30:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 16:30:00 INFO - Using env: {'DISPLAY': ':0', 16:30:00 INFO - 'HOME': '/home/cltbld', 16:30:00 INFO - 'LANG': 'en_US.UTF-8', 16:30:00 INFO - 'LANGUAGE': 'en_US:en', 16:30:00 INFO - 'LOGNAME': 'cltbld', 16:30:00 INFO - 'MAIL': '/var/mail/cltbld', 16:30:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:30:00 INFO - 'MOZ_NO_REMOTE': '1', 16:30:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:30:00 INFO - 'NO_EM_RESTART': '1', 16:30:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:30:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:30:00 INFO - 'PWD': '/builds/slave/test', 16:30:00 INFO - 'SHELL': '/bin/bash', 16:30:00 INFO - 'SHLVL': '1', 16:30:00 INFO - 'TERM': 'linux', 16:30:00 INFO - 'TMOUT': '86400', 16:30:00 INFO - 'USER': 'cltbld', 16:30:00 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1504042539.837449-895384914', 16:30:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:30:00 INFO - '_': '/tools/buildbot/bin/python'} 16:30:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:30:00 INFO - Downloading/unpacking psutil>=3.1.1 16:30:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:30:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:30:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:30:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:30:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:30:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:30:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:30:02 INFO - Installing collected packages: psutil 16:30:02 INFO - Running setup.py install for psutil 16:30:02 INFO - building 'psutil._psutil_linux' extension 16:30:02 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 16:30:02 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 16:30:02 INFO - building 'psutil._psutil_posix' extension 16:30:02 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 16:30:02 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 16:30:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:30:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:30:02 INFO - Successfully installed psutil 16:30:02 INFO - Cleaning up... 16:30:02 INFO - Return code: 0 16:30:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:30:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:30:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:30:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:30:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:30:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfdb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1347580>, '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 0x1348480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1348910>, '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': 'fcadb68e09dcf59683000ff6000001dc-1504042539.837449-895384914', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:30:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:30:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:30:02 INFO - Using env: {'DISPLAY': ':0', 16:30:02 INFO - 'HOME': '/home/cltbld', 16:30:02 INFO - 'LANG': 'en_US.UTF-8', 16:30:02 INFO - 'LANGUAGE': 'en_US:en', 16:30:02 INFO - 'LOGNAME': 'cltbld', 16:30:02 INFO - 'MAIL': '/var/mail/cltbld', 16:30:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:30:02 INFO - 'MOZ_NO_REMOTE': '1', 16:30:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:30:02 INFO - 'NO_EM_RESTART': '1', 16:30:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:30:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:30:02 INFO - 'PWD': '/builds/slave/test', 16:30:02 INFO - 'SHELL': '/bin/bash', 16:30:02 INFO - 'SHLVL': '1', 16:30:02 INFO - 'TERM': 'linux', 16:30:02 INFO - 'TMOUT': '86400', 16:30:02 INFO - 'USER': 'cltbld', 16:30:02 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1504042539.837449-895384914', 16:30:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:30:02 INFO - '_': '/tools/buildbot/bin/python'} 16:30:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:30:02 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:30:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:30:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:30:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:30:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:30:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:30:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:30:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:30:04 INFO - Installing collected packages: mozsystemmonitor 16:30:04 INFO - Running setup.py install for mozsystemmonitor 16:30:04 INFO - Successfully installed mozsystemmonitor 16:30:04 INFO - Cleaning up... 16:30:04 INFO - Return code: 0 16:30:04 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:30:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:30:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:30:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:30:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:30:04 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 0xfdb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1347580>, '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 0x1348480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1348910>, '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': 'fcadb68e09dcf59683000ff6000001dc-1504042539.837449-895384914', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:30:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:30:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:30:04 INFO - Using env: {'DISPLAY': ':0', 16:30:04 INFO - 'HOME': '/home/cltbld', 16:30:04 INFO - 'LANG': 'en_US.UTF-8', 16:30:04 INFO - 'LANGUAGE': 'en_US:en', 16:30:04 INFO - 'LOGNAME': 'cltbld', 16:30:04 INFO - 'MAIL': '/var/mail/cltbld', 16:30:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:30:04 INFO - 'MOZ_NO_REMOTE': '1', 16:30:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:30:04 INFO - 'NO_EM_RESTART': '1', 16:30:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:30:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:30:04 INFO - 'PWD': '/builds/slave/test', 16:30:04 INFO - 'SHELL': '/bin/bash', 16:30:04 INFO - 'SHLVL': '1', 16:30:04 INFO - 'TERM': 'linux', 16:30:04 INFO - 'TMOUT': '86400', 16:30:04 INFO - 'USER': 'cltbld', 16:30:04 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1504042539.837449-895384914', 16:30:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:30:04 INFO - '_': '/tools/buildbot/bin/python'} 16:30:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:30:04 INFO - Downloading/unpacking jsonschema==2.5.1 16:30:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:30:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:30:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:30:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:30:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:30:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:30: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 16:30: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 16:30: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 16:30: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 16:30:05 INFO - Downloading functools32-3.2.3-2.tar.gz 16:30:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:30:05 INFO - warning: no files found matching '*.txt' 16:30:05 INFO - no previously-included directories found matching 'build' 16:30:05 INFO - no previously-included directories found matching 'dist' 16:30:05 INFO - no previously-included directories found matching '.git*' 16:30:05 INFO - Installing collected packages: jsonschema, functools32 16:30:05 INFO - Running setup.py install for functools32 16:30:05 INFO - warning: no files found matching '*.txt' 16:30:05 INFO - no previously-included directories found matching 'build' 16:30:05 INFO - no previously-included directories found matching 'dist' 16:30:05 INFO - no previously-included directories found matching '.git*' 16:30:05 INFO - Successfully installed jsonschema functools32 16:30:05 INFO - Cleaning up... 16:30:05 INFO - Return code: 0 16:30:05 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:30:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:30:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:30:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:30:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:30:05 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 0xfdb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1347580>, '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 0x1348480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1348910>, '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': 'fcadb68e09dcf59683000ff6000001dc-1504042539.837449-895384914', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:30:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:30:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 16:30:05 INFO - Using env: {'DISPLAY': ':0', 16:30:05 INFO - 'HOME': '/home/cltbld', 16:30:05 INFO - 'LANG': 'en_US.UTF-8', 16:30:05 INFO - 'LANGUAGE': 'en_US:en', 16:30:05 INFO - 'LOGNAME': 'cltbld', 16:30:05 INFO - 'MAIL': '/var/mail/cltbld', 16:30:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:30:05 INFO - 'MOZ_NO_REMOTE': '1', 16:30:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:30:05 INFO - 'NO_EM_RESTART': '1', 16:30:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:30:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:30:05 INFO - 'PWD': '/builds/slave/test', 16:30:05 INFO - 'SHELL': '/bin/bash', 16:30:05 INFO - 'SHLVL': '1', 16:30:05 INFO - 'TERM': 'linux', 16:30:05 INFO - 'TMOUT': '86400', 16:30:05 INFO - 'USER': 'cltbld', 16:30:05 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1504042539.837449-895384914', 16:30:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:30:05 INFO - '_': '/tools/buildbot/bin/python'} 16:30:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:30:06 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:30:06 INFO - Cleaning up... 16:30:06 INFO - Return code: 0 16:30:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:30: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')]} 16:30:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:30: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')]} 16:30:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:30:06 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 0xfdb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1347580>, '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 0x1348480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1348910>, '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': 'fcadb68e09dcf59683000ff6000001dc-1504042539.837449-895384914', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:30:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:30:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:30:06 INFO - Using env: {'DISPLAY': ':0', 16:30:06 INFO - 'HOME': '/home/cltbld', 16:30:06 INFO - 'LANG': 'en_US.UTF-8', 16:30:06 INFO - 'LANGUAGE': 'en_US:en', 16:30:06 INFO - 'LOGNAME': 'cltbld', 16:30:06 INFO - 'MAIL': '/var/mail/cltbld', 16:30:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:30:06 INFO - 'MOZ_NO_REMOTE': '1', 16:30:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:30:06 INFO - 'NO_EM_RESTART': '1', 16:30:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:30:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:30:06 INFO - 'PWD': '/builds/slave/test', 16:30:06 INFO - 'SHELL': '/bin/bash', 16:30:06 INFO - 'SHLVL': '1', 16:30:06 INFO - 'TERM': 'linux', 16:30:06 INFO - 'TMOUT': '86400', 16:30:06 INFO - 'USER': 'cltbld', 16:30:06 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1504042539.837449-895384914', 16:30:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:30:06 INFO - '_': '/tools/buildbot/bin/python'} 16:30:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:30:06 INFO - Downloading/unpacking blobuploader==1.2.4 16:30:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:30:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:30:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:30:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:30:07 INFO - Downloading blobuploader-1.2.4.tar.gz 16:30:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:30:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:30:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:30:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:30:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:30:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:30:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:30:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:30:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:30:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:30:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:30:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:30:07 INFO - Downloading docopt-0.6.1.tar.gz 16:30:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:30:07 INFO - Installing collected packages: blobuploader, requests, docopt 16:30:07 INFO - Running setup.py install for blobuploader 16:30:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:30:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:30:08 INFO - Running setup.py install for requests 16:30:08 INFO - Running setup.py install for docopt 16:30:08 INFO - Successfully installed blobuploader requests docopt 16:30:08 INFO - Cleaning up... 16:30:08 INFO - Return code: 0 16:30:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:30:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:30:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:30:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:30:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:30:08 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 0xfdb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1347580>, '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 0x1348480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1348910>, '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': 'fcadb68e09dcf59683000ff6000001dc-1504042539.837449-895384914', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:30:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:30:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:30:08 INFO - Using env: {'DISPLAY': ':0', 16:30:08 INFO - 'HOME': '/home/cltbld', 16:30:08 INFO - 'LANG': 'en_US.UTF-8', 16:30:08 INFO - 'LANGUAGE': 'en_US:en', 16:30:08 INFO - 'LOGNAME': 'cltbld', 16:30:08 INFO - 'MAIL': '/var/mail/cltbld', 16:30:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:30:08 INFO - 'MOZ_NO_REMOTE': '1', 16:30:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:30:08 INFO - 'NO_EM_RESTART': '1', 16:30:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:30:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:30:08 INFO - 'PWD': '/builds/slave/test', 16:30:08 INFO - 'SHELL': '/bin/bash', 16:30:08 INFO - 'SHLVL': '1', 16:30:08 INFO - 'TERM': 'linux', 16:30:08 INFO - 'TMOUT': '86400', 16:30:08 INFO - 'USER': 'cltbld', 16:30:08 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1504042539.837449-895384914', 16:30:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:30:08 INFO - '_': '/tools/buildbot/bin/python'} 16:30:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:30:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:30:08 INFO - Running setup.py (path:/tmp/pip-dgqbSE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:30:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:30:08 INFO - Running setup.py (path:/tmp/pip-jA06Kn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:30:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:30:08 INFO - Running setup.py (path:/tmp/pip-g6LXvE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:30:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:30:08 INFO - Running setup.py (path:/tmp/pip-InOfbi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:30:09 INFO - Running setup.py (path:/tmp/pip-Nvflhl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:30:09 INFO - Running setup.py (path:/tmp/pip-BwbSfd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:30:09 INFO - Running setup.py (path:/tmp/pip-wH3P0B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:30:09 INFO - Running setup.py (path:/tmp/pip-z8dNG5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:30:09 INFO - Running setup.py (path:/tmp/pip-bMExOv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:30:09 INFO - Running setup.py (path:/tmp/pip-CAKX8W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:30:09 INFO - Running setup.py (path:/tmp/pip-cKB3GT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:30:09 INFO - Running setup.py (path:/tmp/pip-Wkftsj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:30:09 INFO - Running setup.py (path:/tmp/pip-kMhM7r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:30:09 INFO - Running setup.py (path:/tmp/pip-2WHsYc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:30:09 INFO - Running setup.py (path:/tmp/pip-lT0fsi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:30:09 INFO - Running setup.py (path:/tmp/pip-irNDCq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:30:09 INFO - Running setup.py (path:/tmp/pip-f_I6t5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:30:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:30:09 INFO - Running setup.py install for manifestparser 16:30:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:30:10 INFO - Running setup.py install for mozcrash 16:30:10 INFO - Running setup.py install for mozdebug 16:30:10 INFO - Running setup.py install for mozdevice 16:30:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:30:10 INFO - Running setup.py install for mozfile 16:30:10 INFO - Running setup.py install for mozhttpd 16:30:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:30:10 INFO - Running setup.py install for mozinfo 16:30:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:30:10 INFO - Running setup.py install for mozInstall 16:30:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:30:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:30:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:30:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:30:10 INFO - Running setup.py install for mozleak 16:30:10 INFO - Running setup.py install for mozlog 16:30:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:30:11 INFO - Running setup.py install for moznetwork 16:30:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:30:11 INFO - Running setup.py install for mozprocess 16:30:11 INFO - Running setup.py install for mozprofile 16:30:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:30:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:30:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:30:11 INFO - Running setup.py install for mozrunner 16:30:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:30:11 INFO - Running setup.py install for mozscreenshot 16:30:11 INFO - Running setup.py install for moztest 16:30:11 INFO - Running setup.py install for mozversion 16:30:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:30:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:30:11 INFO - Cleaning up... 16:30:11 INFO - Return code: 0 16:30:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:30:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:30:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:30:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:30:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:30:11 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 0xfdb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1347580>, '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 0x1348480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1348910>, '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': 'fcadb68e09dcf59683000ff6000001dc-1504042539.837449-895384914', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:30:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:30:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:30:11 INFO - Using env: {'DISPLAY': ':0', 16:30:11 INFO - 'HOME': '/home/cltbld', 16:30:11 INFO - 'LANG': 'en_US.UTF-8', 16:30:11 INFO - 'LANGUAGE': 'en_US:en', 16:30:11 INFO - 'LOGNAME': 'cltbld', 16:30:11 INFO - 'MAIL': '/var/mail/cltbld', 16:30:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:30:11 INFO - 'MOZ_NO_REMOTE': '1', 16:30:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:30:11 INFO - 'NO_EM_RESTART': '1', 16:30:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:30:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:30:11 INFO - 'PWD': '/builds/slave/test', 16:30:11 INFO - 'SHELL': '/bin/bash', 16:30:11 INFO - 'SHLVL': '1', 16:30:11 INFO - 'TERM': 'linux', 16:30:11 INFO - 'TMOUT': '86400', 16:30:11 INFO - 'USER': 'cltbld', 16:30:11 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1504042539.837449-895384914', 16:30:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:30:11 INFO - '_': '/tools/buildbot/bin/python'} 16:30:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:30:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:30:11 INFO - Running setup.py (path:/tmp/pip-fJiPUG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:30:12 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 16:30:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:30:12 INFO - Running setup.py (path:/tmp/pip-wAWHA5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:30:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:30:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:30:12 INFO - Running setup.py (path:/tmp/pip-jClhJM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:30:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:30:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:30:12 INFO - Running setup.py (path:/tmp/pip-bobzFs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:30:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:30:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:30:12 INFO - Running setup.py (path:/tmp/pip-iW5AhJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:30:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 16:30:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:30:12 INFO - Running setup.py (path:/tmp/pip-OsHjo6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:30:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 16:30:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:30:12 INFO - Running setup.py (path:/tmp/pip-qSiWVN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:30:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 16:30:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:30:12 INFO - Running setup.py (path:/tmp/pip-a0NzXC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:30:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:30:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:30:12 INFO - Running setup.py (path:/tmp/pip-ivBYQk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:30:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 16:30:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:30:12 INFO - Running setup.py (path:/tmp/pip-yhOEzL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:30:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:30:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:30:12 INFO - Running setup.py (path:/tmp/pip-gBfLfs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:30:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 16:30:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:30:12 INFO - Running setup.py (path:/tmp/pip-MRooXv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:30:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:30:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:30:12 INFO - Running setup.py (path:/tmp/pip-SetcSr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:30:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 16:30:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:30:12 INFO - Running setup.py (path:/tmp/pip-ZFUwAj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:30:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:30:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:30:12 INFO - Running setup.py (path:/tmp/pip-FGGgsG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:30:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 16:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:30:13 INFO - Running setup.py (path:/tmp/pip-IANpgp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:30:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 16:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:30:13 INFO - Running setup.py (path:/tmp/pip-wK38Wo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:30:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 16:30:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:30:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:30:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:30:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:30:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:30:13 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:30:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:30:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:30:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:30:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:30:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:30:14 INFO - Downloading blessings-1.6.tar.gz 16:30:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:30:14 INFO - Installing collected packages: blessings 16:30:14 INFO - Running setup.py install for blessings 16:30:14 INFO - Successfully installed blessings 16:30:14 INFO - Cleaning up... 16:30:14 INFO - Return code: 0 16:30:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:30:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:30:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:30:14 INFO - Reading from file tmpfile_stdout 16:30:14 INFO - Current package versions: 16:30:14 INFO - argparse == 1.2.1 16:30:14 INFO - blessings == 1.6 16:30:14 INFO - blobuploader == 1.2.4 16:30:14 INFO - docopt == 0.6.1 16:30:14 INFO - functools32 == 3.2.3-2 16:30:14 INFO - jsonschema == 2.5.1 16:30:14 INFO - manifestparser == 1.1 16:30:14 INFO - mozInstall == 1.13 16:30:14 INFO - mozcrash == 1.0 16:30:14 INFO - mozdebug == 0.1 16:30:14 INFO - mozdevice == 0.51 16:30:14 INFO - mozfile == 1.2 16:30:14 INFO - mozhttpd == 0.7 16:30:14 INFO - mozinfo == 0.10 16:30:14 INFO - mozleak == 0.1 16:30:14 INFO - mozlog == 3.5 16:30:14 INFO - moznetwork == 0.27 16:30:14 INFO - mozprocess == 0.25 16:30:14 INFO - mozprofile == 0.28 16:30:14 INFO - mozrunner == 6.13 16:30:14 INFO - mozscreenshot == 0.1 16:30:14 INFO - mozsystemmonitor == 0.3 16:30:14 INFO - moztest == 0.8 16:30:14 INFO - mozversion == 1.4 16:30:14 INFO - psutil == 3.1.1 16:30:14 INFO - requests == 1.2.3 16:30:14 INFO - wsgiref == 0.1.2 16:30:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:30:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:30:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:30:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:30:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:30:14 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 0xfdb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1347580>, '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 0x1348480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1348910>, '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': 'fcadb68e09dcf59683000ff6000001dc-1504042539.837449-895384914', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:30:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 16:30:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:30:14 INFO - Using env: {'DISPLAY': ':0', 16:30:14 INFO - 'HOME': '/home/cltbld', 16:30:14 INFO - 'LANG': 'en_US.UTF-8', 16:30:14 INFO - 'LANGUAGE': 'en_US:en', 16:30:14 INFO - 'LOGNAME': 'cltbld', 16:30:14 INFO - 'MAIL': '/var/mail/cltbld', 16:30:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:30:14 INFO - 'MOZ_NO_REMOTE': '1', 16:30:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:30:14 INFO - 'NO_EM_RESTART': '1', 16:30:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:30:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:30:14 INFO - 'PWD': '/builds/slave/test', 16:30:14 INFO - 'SHELL': '/bin/bash', 16:30:14 INFO - 'SHLVL': '1', 16:30:14 INFO - 'TERM': 'linux', 16:30:14 INFO - 'TMOUT': '86400', 16:30:14 INFO - 'USER': 'cltbld', 16:30:14 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1504042539.837449-895384914', 16:30:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:30:14 INFO - '_': '/tools/buildbot/bin/python'} 16:30:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:30:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:30:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 16:30:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 16:30:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:30:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 16:30:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 16:30:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 16:30:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 16:30:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 16:30:14 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 16:30:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:30:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:30:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:30:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:30:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 16:30:16 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:30:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:30:16 INFO - Installing collected packages: simplejson 16:30:16 INFO - Running setup.py install for simplejson 16:30:16 INFO - building 'simplejson._speedups' extension 16:30:16 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 16:30:17 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 16:30:17 INFO - Successfully installed simplejson 16:30:17 INFO - Cleaning up... 16:30:17 INFO - Return code: 0 16:30:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:30:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:30:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:30:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:30:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:30:17 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 0xfdb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1347580>, '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 0x1348480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1348910>, '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': 'fcadb68e09dcf59683000ff6000001dc-1504042539.837449-895384914', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:30:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:30:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:30:17 INFO - Using env: {'DISPLAY': ':0', 16:30:17 INFO - 'HOME': '/home/cltbld', 16:30:17 INFO - 'LANG': 'en_US.UTF-8', 16:30:17 INFO - 'LANGUAGE': 'en_US:en', 16:30:17 INFO - 'LOGNAME': 'cltbld', 16:30:17 INFO - 'MAIL': '/var/mail/cltbld', 16:30:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:30:17 INFO - 'MOZ_NO_REMOTE': '1', 16:30:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:30:17 INFO - 'NO_EM_RESTART': '1', 16:30:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:30:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:30:17 INFO - 'PWD': '/builds/slave/test', 16:30:17 INFO - 'SHELL': '/bin/bash', 16:30:17 INFO - 'SHLVL': '1', 16:30:17 INFO - 'TERM': 'linux', 16:30:17 INFO - 'TMOUT': '86400', 16:30:17 INFO - 'USER': 'cltbld', 16:30:17 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1504042539.837449-895384914', 16:30:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:30:17 INFO - '_': '/tools/buildbot/bin/python'} 16:30:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:30:17 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:30:17 INFO - Cleaning up... 16:30:17 INFO - Return code: 0 16:30:17 INFO - Running post-action listener: _resource_record_post_action 16:30:17 INFO - Running post-action listener: _start_resource_monitoring 16:30:17 INFO - Starting resource monitoring. 16:30:17 INFO - [mozharness: 2017-08-29 23:30:17.639304Z] Finished create-virtualenv step (success) 16:30:17 INFO - [mozharness: 2017-08-29 23:30:17.639831Z] Running install step. 16:30:17 INFO - Running pre-action listener: _resource_record_pre_action 16:30:17 INFO - Running main action method: install 16:30:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:30:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:30:17 INFO - Reading from file tmpfile_stdout 16:30:17 INFO - Detecting whether we're running mozinstall >=1.0... 16:30:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:30:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:30:18 INFO - Reading from file tmpfile_stdout 16:30:18 INFO - Output received: 16:30:18 INFO - Usage: mozinstall [options] installer 16:30:18 INFO - Options: 16:30:18 INFO - -h, --help show this help message and exit 16:30:18 INFO - -d DEST, --destination=DEST 16:30:18 INFO - Directory to install application into. [default: 16:30:18 INFO - "/builds/slave/test"] 16:30:18 INFO - --app=APP Application being installed. [default: firefox] 16:30:18 INFO - mkdir: /builds/slave/test/build/application 16:30:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:30:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 16:30:34 INFO - Reading from file tmpfile_stdout 16:30:34 INFO - Output received: 16:30:34 INFO - /builds/slave/test/build/application/firefox/firefox 16:30:34 INFO - Running post-action listener: _resource_record_post_action 16:30:34 INFO - [mozharness: 2017-08-29 23:30:34.468312Z] Finished install step (success) 16:30:34 INFO - [mozharness: 2017-08-29 23:30:34.468592Z] Running setup-mitmproxy step. 16:30:34 INFO - Running pre-action listener: _resource_record_pre_action 16:30:34 INFO - Running main action method: setup_mitmproxy 16:30:34 INFO - Skipping: mitmproxy is not required 16:30:34 INFO - Running post-action listener: _resource_record_post_action 16:30:34 INFO - [mozharness: 2017-08-29 23:30:34.469697Z] Finished setup-mitmproxy step (success) 16:30:34 INFO - [mozharness: 2017-08-29 23:30:34.469914Z] Running run-tests step. 16:30:34 INFO - Running pre-action listener: _resource_record_pre_action 16:30:34 INFO - Running pre-action listener: _set_gcov_prefix 16:30:34 INFO - Running main action method: run_tests 16:30:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:30:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:30:34 INFO - Python 2.7.3 16:30:34 INFO - Return code: 0 16:30:34 INFO - grabbing minidump binary from tooltool 16:30:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:30:34 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 0x1347580>, '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 0x1348480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1348910>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:30:34 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:30:34 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 16:30:34 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 16:30:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:30:34 INFO - Return code: 0 16:30:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:30:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:30:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:30:34 INFO - ENV: RUST_BACKTRACE is now full 16:30:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:30:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:30:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OLOX1rRMRjiLLTkG5J30Ew/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-075', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 16:30:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OLOX1rRMRjiLLTkG5J30Ew/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-075 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 16:30:34 INFO - Using env: {'DISPLAY': ':0', 16:30:34 INFO - 'HOME': '/home/cltbld', 16:30:34 INFO - 'LANG': 'en_US.UTF-8', 16:30:34 INFO - 'LANGUAGE': 'en_US:en', 16:30:34 INFO - 'LOGNAME': 'cltbld', 16:30:34 INFO - 'MAIL': '/var/mail/cltbld', 16:30:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:30:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:30:34 INFO - 'MOZ_ACCELERATED': '1', 16:30:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:30:34 INFO - 'MOZ_NO_REMOTE': '1', 16:30:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:30:34 INFO - 'MOZ_WEBRENDER': '1', 16:30:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:30:34 INFO - 'NO_EM_RESTART': '1', 16:30:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:30:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:30:34 INFO - 'PWD': '/builds/slave/test', 16:30:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:30:34 INFO - 'RUST_BACKTRACE': 'full', 16:30:34 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:30:34 INFO - 'SHELL': '/bin/bash', 16:30:34 INFO - 'SHLVL': '1', 16:30:34 INFO - 'TERM': 'linux', 16:30:34 INFO - 'TMOUT': '86400', 16:30:34 INFO - 'USER': 'cltbld', 16:30:34 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1504042539.837449-895384914', 16:30:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:30:34 INFO - '_': '/tools/buildbot/bin/python'} 16:30:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OLOX1rRMRjiLLTkG5J30Ew/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-075', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 16:30:34 INFO - mozversion application_buildid: 20170829223806 16:30:34 INFO - mozversion application_changeset: 8f221407c6006ac1de529da77ecc18431dde3e99 16:30:34 INFO - mozversion application_display_name: Nightly 16:30:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:30:34 INFO - mozversion application_name: Firefox 16:30:34 INFO - mozversion application_remotingname: firefox 16:30:34 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:30:34 INFO - mozversion application_vendor: Mozilla 16:30:34 INFO - mozversion application_version: 57.0a1 16:30:34 INFO - mozversion platform_buildid: 20170829223806 16:30:34 INFO - mozversion platform_changeset: 8f221407c6006ac1de529da77ecc18431dde3e99 16:30:34 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:30:34 INFO - mozversion platform_version: 57.0a1 16:30:34 INFO - using testdate: 1504049434 16:30:34 INFO - actual date: 1504049434 16:30:34 INFO - starting webserver on 'localhost:54155' 16:30:34 INFO - SUITE-START | Running 2 tests 16:30:34 INFO - TEST-START | dromaeo_css 16:30:34 INFO - Initialising browser for dromaeo_css test... 16:30:34 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:54155/getInfo.html -profile /tmp/tmpSkXiOV/profile 16:30:34 INFO - TEST-INFO | started process 621 (/builds/slave/test/build/application/firefox/firefox http://localhost:54155/getInfo.html) 16:30:42 INFO - TEST-INFO | 621: exit 0 16:30:42 INFO - Browser initialized. 16:30:42 INFO - Running cycle 1/1 for dromaeo_css test... 16:30:42 INFO - Using env: {'DISPLAY': ':0', 16:30:42 INFO - 'HOME': '/home/cltbld', 16:30:42 INFO - 'JSGC_DISABLE_POISONING': '1', 16:30:42 INFO - 'LANG': 'en_US.UTF-8', 16:30:42 INFO - 'LANGUAGE': 'en_US:en', 16:30:42 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 16:30:42 INFO - 'LOGNAME': 'cltbld', 16:30:42 INFO - 'MAIL': '/var/mail/cltbld', 16:30:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:30:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:30:42 INFO - 'MOZ_ACCELERATED': '1', 16:30:42 INFO - 'MOZ_CRASHREPORTER': '1', 16:30:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:30:42 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 16:30:42 INFO - 'MOZ_NO_REMOTE': '1', 16:30:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:30:42 INFO - 'MOZ_WEBRENDER': '1', 16:30:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:30:42 INFO - 'NO_EM_RESTART': '1', 16:30:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:30:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:30:42 INFO - 'PWD': '/builds/slave/test', 16:30:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:30:42 INFO - 'RUST_BACKTRACE': 'full', 16:30:42 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:30:42 INFO - 'SHELL': '/bin/bash', 16:30:42 INFO - 'SHLVL': '1', 16:30:42 INFO - 'TERM': 'linux', 16:30:42 INFO - 'TMOUT': '86400', 16:30:42 INFO - 'USER': 'cltbld', 16:30:42 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1504042539.837449-895384914', 16:30:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:30:42 INFO - '_': '/tools/buildbot/bin/python'} 16:30:42 INFO - TEST-INFO | started process 824 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSkXiOV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:30:43 INFO - PID 824 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 16:30:43 INFO - PID 824 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 16:30:43 INFO - PID 824 | 16:30:43 INFO - PID 824 | (/builds/slave/test/build/application/firefox/firefox:886): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:30:43 INFO - PID 824 | 16:30:54 INFO - PID 824 | RSS: Main: 200396800 16:30:54 INFO - PID 824 | 16:30:57 INFO - PID 824 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 16:33:54 INFO - PID 824 | Cycle 1(1): loaded http://localhost:54155/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54155/tests/dromaeo/cssquery-ext.html) 16:33:55 INFO - PID 824 | RSS: Main: 214183936 16:33:55 INFO - PID 824 | 16:36:57 INFO - PID 824 | Cycle 1(1): loaded http://localhost:54155/tests/dromaeo/cssquery-ext.html (next: http://localhost:54155/tests/dromaeo/cssquery-jquery.html) 16:36:57 INFO - PID 824 | RSS: Main: 212201472 16:36:57 INFO - PID 824 | 16:39:59 INFO - PID 824 | Cycle 1(1): loaded http://localhost:54155/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54155/tests/dromaeo/cssquery-mootools.html) 16:40:00 INFO - PID 824 | RSS: Main: 214228992 16:40:00 INFO - PID 824 | 16:43:02 INFO - PID 824 | Cycle 1(1): loaded http://localhost:54155/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54155/tests/dromaeo/cssquery-prototype.html) 16:43:03 INFO - PID 824 | RSS: Main: 212791296 16:43:03 INFO - PID 824 | 16:46:07 INFO - PID 824 | Cycle 1(1): loaded http://localhost:54155/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54155/tests/dromaeo/cssquery-yui.html) 16:46:07 INFO - PID 824 | RSS: Main: 214417408 16:46:07 INFO - PID 824 | 16:49:09 INFO - PID 824 | Cycle 1(1): loaded http://localhost:54155/tests/dromaeo/cssquery-yui.html (next: http://localhost:54155/tests/dromaeo/cssquery-dojo.html) 16:49:10 INFO - PID 824 | RSS: Main: 217202688 16:49:10 INFO - PID 824 | 16:49:10 INFO - PID 824 | __start_tp_report 16:49:10 INFO - PID 824 | _x_x_mozilla_page_load 16:49:10 INFO - PID 824 | _x_x_mozilla_page_load_details 16:49:10 INFO - PID 824 | |i|pagename|runs| 16:49:10 INFO - PID 824 | |0;dojo.html;3255.560499332589;3278.1968417737644;3292.835358232088;3319.5684561007065;3348.4475061614835;6153.16932214151;6327.272363678178;6346.746130154788;6347.8413039673915;6398.936010639893;6089.817305480843;6175.845603859906;6193.566450348466;6202.565820392574;6214.130021796952;5701.885962280752;5770.740316685759;5779.190913272145;5784.103463963072;5792.420757924216;5762.855928601776;5812.970935145339;5832.212651292085;5832.766689332421;5842.21130147431;5765.077587585987;5825.388334224909;5878.735456904449;5896.380880007602;5912.17229587858;5799.594028418012;5832.096025116092;5841.4450627190345;5881.117832325164;5934.317553481362;5674.971625141848;5784.652920824764;5861.501772349356;5880.117982302646;5907.704614769287;5539.120825028839;6030.366811484775;6125.601835880653;6144.262688477366;6171.197744293213;6685.632290224035;6712.362325579063;6776.898346524757;6807.727690892359;6826.214985276707;6562.704678289489;6784.050232967388;6796.286389929085;6872.209695884987;6874.140732408449;6209.410106039919;6215.720292586844;6217.378262173792;6221.87556248877;6243.719032643542;6827.112475378169;6873.553219040747;6874.621895795779;6874.690638921161;6882.931170688329;6495.1556297681;6529.608223506605;6536.215654121441;6542.214934207926;6542.34576542342;6733.124693789776;6756.966215168893;6757.425618822357;6767.661616919135;6775.1531058617675;6338.556301058974;6609.1077704510235;6710.597364158069;6719.160104986877;6752.122224110834;6706.865862682719;6712.798616041527;6798.320167983162;6801.591904485746;6811.625360605214;5191.688498690015;5277.577793776489;5291.656042357312;5294.7352632369;5302.125149350314;4660.067986402665;4689.648276379286;4718.3158442025715;4747.335373047776;4766.451858036301;5821.476067153976;5835.124731290255;5926.911096333559;5930.970345148333;5933.970330148408;6577.6053436793945;6707.262201157869;6711.7315307388135;6715.6977935993;6812.046313516112;5767.279090113736;5772.711364431846;5793.942060579425;5810.331811841608;5812.099124635688;5754.108113242454;5757.596968212185;5777.711114444261;5780.075187969988;5781.942180578225;6339.873202535923;6350.491960643138;6404.871902562016;6434.131392262078;6446.194225721785;6581.605103693793;6623.105880706043;6632.801015969529;6758;6815.795526134224;6484.935150648622;6491.545591808717;6529.412352888263;6572.76995305162;6593.901091483535;6423.261324947691;6524.282328943717;6618.172728408949;6644.435223006099;6721.932780672326;6657.06801047844;6698.39714425704;6729.427998619976;6740.258571557027;6777.830554235987;6547.476201903741;6549.705263263069;6586.37429444202;6605.702743376656;6612.305707900794;6447.129637498878;6475.611463312216;6562.409383155539;6575.079488871466;6577.572457790228;6417.582857114273;6421.389967953037;6462.450691691259;6515.967420162869;6522;6426.839329016812;6472.482201423969;6615.66921653925;6659.766908158385;6718.428933540704;6163.476104531165;6232.407921247474;6251.4061164189325;6477.384648458389;6498.220213574401 16:49:10 INFO - PID 824 | |1;ext.html;801.1307731111743;825.1583384947351;832.105486601903;865.9220670139687;876.8991565969916;38049.619503804955;39160.60839391609;39203.21593568134;39472.60527394729;39670.40494392587;35992.82003589985;36058;36216;36402.817985910035;36508.45237321442;6775.728970841161;6844.760433384808;6877.656117194146;6916.377526022657;6954.200266969313;6856.142982127234;6938.514303998722;6942.652867356637;6944.47916406269;6952.652367381636;6873.896891546631;6908;6928.237893831674;7458.440616953751;7805.60971951403;7680.155182929873;7686.5772382518935;7687.923120768776;7740.496867703581;7761.7671469855995;7559.886601700924;7638.159802421729;7652.961735191288;7654.770356889302;7655;35405.114872128404;35947.82026089879;36058.09854753652;36201.456978145085;36227;3470.340635279314;3482.6517348265224;3495.1262184453885;3501.7198624110265;3522.1018640246575;30512.237194070105;30513.542296865566;30579.388412231852;30689.38621227585;30698.693013069806;4999.525045120708;5013.924791128136;5120.795168193268;5134.2812006319145;5246.31797866275;187727;190566;190637;208522;213845;44490;44913.77543112264;44927.77536112364;45057.774711126236;45060.54939450629;46017.30974035392;46151.53848461472;46257.537424625996;46525.30212046822;46612.06775864464;15276.312565934559;15626.140562268956;15661.843381566267;15723.135227562594;15948.601284967737;13240.404181811842;13389.531366402129;13393.799093013613;13395.330233488286;13405.731885362433;13006.349682516025;13076.411561479756;13083.738325233442;13097.738045239043;13141.211527308393;5458.645188062763;5476.616636835463;5526.47498487643;5587.720613969285;5639.718014099279;997.3517213811081;1005.6379703306803;1012.2863381316155;1016.339379403379;1024.6208902706046;22257.332280031624;22417;22623.43441413945;22740.20409285667;22999.195028173934;1071.3571856885806;1101.8457415961611;1104.5471356743697;1106.4799544214206;1122.6968718446137;11846.585369512199;11967.820482692767;11997.460114294878;12060;15420.151891645843;232847;233746;234411;235355;235399;50609.493905061216;50715.47853564399;50736.74631626818;50741.49258507442;50823.745881270355;1366.931653417345;1426.5292453490324;1426.5435060780658;1434.2900264369205;1441.4666573368131;25897.611535827353;25958.480830383665;25989.480210395308;25990.740092598833;26292;30381.392372152874;33684.3263134731;34936.825315873255;34940.30119397547;34961.65038349584;209570;210876;211743;211788;212108;27336.72663273342;27706.168814935583;27848.16455506338;29749.702502974695;31196.220094497818;38944.2211155781;38968.80515597404;39075;39188.80405597954;39682.80158599304;29565.408691826473;30039.399212016073;30118.84940575283;30201.848990754905;30214.69785302119;29204.56193157147;29347.119586412442;29380.265493362836;29599.112026639235;29779.404411912074;32993.34013319768;33077.834610826794;35686.64313356833;36565.45151822778;36606.45090323594;27431.451370972867;27845.050846441365;27942.44115117727;28354.43291134207;28555.42889142164;23435.76564234336;23570.410739731644;23778.40553986095;23944;24004.15985440501 16:49:10 INFO - PID 824 | |2;jquery.html;548.3419896124649;559.4657102467145;560.3835780641298;561.3684604819578;582.1965687351455;21210.6818397724;21796.128154873804;21809.67285490717;21893.562128757414;22466.213682521116;22885.542289154208;23241.30276091716;23340.066397344086;23399.883000584974;23511.882440587815;6607.570507916982;6736.932630673679;6743.629100399476;6758.729650813962;6765.898511522331;5943.108533719934;6576.934230657704;6623.834404139911;6629.8342541436605;6635.966820165892;6484.708188131545;6523.054157147235;6532.183477065367;6532.869342613145;6539.117219175422;6470.935290647104;6533.31400202979;6548.9017664735065;6549.901751473732;6556.049372840959;6068.757249710006;6070.8785824283705;6073.483753880925;6084.665343406111;6088.360722124202;28821.27946801347;29866.552001719992;30194.24514387158;30554.930577429684;30908.845455772804;2025.605007023631;2040.6224848403092;2045.5499790046167;2052.9281475148446;2065.029436165;19179;19684.50788730279;19766.110525026408;19781.40655780329;19893.303734369372;2182.694422780812;2228.6099932511747;2242.2040175737543;2337.731160916482;2518.8614626195554;130931;134598;135580.3220983889;135628.3218583901;136083;14268.14391136535;14437.133771973715;14674.853251467563;14912.70174596502;14950.551483455514;22952.311430657108;22962;23002.539949200924;23084.53830923372;23161.189358372376;10214.131798797036;10395.16838652906;10433.21750868688;10491.475426228659;10577.524011419504;9716.95141524302;9729.173020293354;9763.170130538983;9920.255980801468;9948.154406875497;8789.692360767342;8846.513441760637;8976.192142707188;9016.684416045407;9383.733196018587;2593.9092131775674;2618.738126187366;2705.1613999660167;2733.5079685656374;2738.548139556951;948.3314263444255;975.3124047546463;975.4342481360794;983.9458829764432;990.6334656177116;19254.326098586484;19503.122359493856;19522;19551.804481954998;20072.89963550173;1038.678009816959;1047.3872784421199;1066.6906597086759;1073.2111897755144;1076.6716151573846;10508.159347252202;10865;10885.455727213608;11019.228653994143;11083.42529573608;464376;466005;466337;468359;482967;104904.47547762365;107569;107660.461697691;108286.45856770666;109470;1173.1260211142583;1195.7070517723214;1202.0864143251192;1204.1931905623253;1209.2563073709605;17095.91452042732;17254;17420.216090275713;17756.11219438997;17994.640107198044;54255.72872135614;54881.176782347495;55484.72257638848;55684.72157639186;56398.718006409705;66968.33031669621;67051.66474167598;67144.32855671381;67284.32715672976;68314.65842670755;14034.719305613626;14195.787063194268;14276;14289.571312860631;14359.353829077925;22287.331380058626;22746.65880011768;22866.31401057971;22885.88557057204;22897.65653515165;17826.5543361417;17996.640067198845;18143.637127257116;18241.179146938153;18241.361552345603;16002.439914602934;16404;16646.16769161513;17202.65594688124;17222.65554688874;17186.570335741708;17208;17260.309587616353;17388;17557.561060973578;13544.79682804739;13854.03021788465;14089.225092619594;14246.715065698836;14269.785953210503;16998.405055822986;17000.23498942526;17069.743953840454;17123.571910702332;17170.39903603368 16:49:10 INFO - PID 824 | |3;mootools.html;1323.7617228898798;1360.4354193009901;1394.3585950462793;1402.144691738039;1408.2114016150956;14409.927950360247;14944.701105977874;15027.549173524785;15032.624184395396;15160.09039457632;13689.589312320646;14264.0728352657;14548.418063277457;14603.415863365479;14646;2699.784017278613;2778.3748656552216;2799.7340252675963;2801.089645865092;2804.2008027712104;2608.6478325426015;2660.4546068056;2727.1136880513914;2743;2745.766609838166;2725.822821516595;2748.7938404619636;2752.8073034887566;2753.435545713134;2759.4619049285398;2618.5205358972216;2650.8011899107546;2653.5223659741337;2683.798715096356;2697.109953715269;2611.6996545397333;2626.1071235779737;2645.5899335603012;2647;2647.2984659065364;14100.647483812883;14359.856401435956;14427.35076921541;14465.05977111495;14466.49367272151;7866.528008319462;8165.101838797727;8172.427930044899;8197.836043279161;8205;5280.498352656491;5296.417394086686;5320.760565774511;5460.645058071253;5603.075492543725;1871.803460636627;1875.1280654495588;1894.5737209127974;1896.1872310791734;1936.66108431024;25010.249692509253;25272.747272527406;25296.873515632305;25309.62035569468;25340.366490837692;6499.967500162564;6660.733570657217;6806.353396427331;6857.211420686585;6877.3810357067105;16425.753613695804;16499.83500165007;16523.83476165247;16527.752083718755;16675.416360427327;7450.143233528105;7454.142773580999;7467.813304667318;7503.512271702322;7523.0972283326355;6793.5244532882225;6865.9313406866295;6946.16646002483;7024.297570242935;7024.5434046786795;5081.28861959326;5285.048691235537;5317.867053323698;5334.733263336818;5366.16824392212;1428.9857101428852;1456.9125852448888;1509.9320530576151;1530.5867415797672;1538.3077615073262;870.0820634230821;881.6385282034463;892.9151730585584;909.0682050897883;909.4952301472746;7301.89047164293;7327.120745510573;7350.4119670426235;8430.283425908867;8849.20357167845;997.7306127345721;1002.5087707023506;1006.6174853555748;1015.4161357219629;1020.1481762728057;4903.632227582945;5055.6713813602;5093.898122037613;5110.386753589519;5165.690058596496;20095.095720692603;20095.598088038158;20930.267440639505;20976.37070887876;20980.26569070075;19582.31461898827;20895.582088358453;20965.580688386453;21021.894890525757;21137.577248454945;10730.356178629307;11256.21206515536;11423.999999999834;11434.02810761078;11437.656870293904;8152.959235203786;8430.199131082538;8475.57622118904;8491.702790402307;8494.660213591635;17598.73601895947;17867.553311167325;18054.729179062062;18158.45524634263;18317.358892439235;17768;17789.555261118574;17820.198091085673;18374.908125459286;19203.231870725573;11330.830037549278;11430.25703329281;11546.94226528862;11552.249103808226;11568.710782230512;12827.551035713705;13280.601581952556;13548.25484598317;13642.181469111885;13655.248961307223;10866.61966831157;11027.503762330874;11132.610358637408;11172.329660220414;11258.943705281421;10843.132549395872;10911.836322455329;11268.38023908693;11342.432878356214;11360.488778004845;8431.536265505456;8444.746657600283;8496.320294376312;8508.446950948168;8535.31717462589;6997.160340759141;7022.613756243456;7065.364117229474;7068.646567671699;7069;7072.151341839012;7131.322524360177;7144.3570078693165;7204.279572042754;7228.349448549656 16:49:10 INFO - PID 824 | |4;prototype.html;449.58638052991245;485.5096352683788;486.79797883878194;495.5628676837173;530.202045920889;6006.669633170174;6242.563020588561;6314.40013198746;6353.745850165988;6417.839554011152;6181.690915454232;6190.409562453778;6218.25380954285;6226.474513744128;6278.968605156979;4891.5353041461;4906.337644417994;4955.306257123987;4969.478204788499;4987.975060124694;4801.2798080287885;4932.876678083041;4950.653454258203;4960.578350840165;4962.379702537183;4902;4931.876703082434;4944.110060189165;4953.678010929296;4990.800367985276;4912.0597364041005;4912.557869791736;4941.308216849644;4944.604431645478;4954;4405.713628614129;4419.889502762425;4429.712068715523;4453.376527286183;4455.910881782379;6142.262928448615;6149.262088549358;6159.722812473449;6173.981293086636;6200.658963756991;5644.266245388114;5650.660960342392;5657.179708942181;5679.346875109332;5701.971490142523;6606.768763093317;6675.699593518303;6677.966610166966;6681.832954176136;6691.966540167316;4825.396825396825;4827.493113223131;4827.879303017417;4849.854504364839;4890.095332363524;6861.407952518682;6866.244713081607;6911.654417279166;6947.3747362736585;7045.506814522985;5034.270030845507;5043.319151914445;5049.116404629175;5052.72210028452;5059.62052846038;5000.399952005782;5105.106606343949;5121.513456221653;5129.435522165701;5139.948600514022;5586.860328491739;5629.352624448159;5655.1517272409465;5669.291338582677;5676.744546495418;6553.246376666649;6567.343265673395;6620.238672552622;6659.367360100783;6697.631630260285;1671.5319710481085;1699.5836020175136;1705.9061751603533;1728.4037007232484;1752.9211185496429;1199.220506670671;1200.8799120088097;1230.354064116346;1231.599730087725;1236.505397840871;5725.77096916127;5787.594868359259;5790.131480277908;5806.274215723035;5858.589898707135;6485.643289619116;6836.658167091725;6836.6923488443135;6859.382655561023;6880.518363714492;5785.190073389729;5846.269216347957;5864.912026319608;5884.852878677982;5908.763649454059;3555.6977656899453;3603.873864414733;3612.422012477991;3632.3824949758605;3645.4714066460747;6522.412982831473;6527.510436717265;6570.113034740344;6575.967120164369;6583.473322134218;6983.546069505466;7012.824679383056;7017.578945263199;7040.401565866856;7042.401395881408;6475.255345635313;6490.448311893542;6603.636799975951;6644.800655980328;6659.234188068337;6730.125083739278;6766.1880574329425;6800.387965083166;6833.624150671761;6859.416949559144;6708.798736037927;6717.328267173439;6744.7976560703255;6752.426043786333;6799.966000170165;6502.154719886385;6502.869942601027;6599.934000659932;6606.504512161703;6659.800205993828;4952.925706114484;4957.429895561912;4985.554189285212;4990.6007519397635;4995.675281106716;6699.459124401513;6703;6745.5952642841585;6828.180618325634;6833.248342682202;6366.395192456709;6503.414692677682;6573.1783527059115;6603.603783772797;6634.436072933855;6428.292887782433;6576.210854697276;6577.572457790228;6626.966865165643;6696.966515167393;6408.967955160194;6464.644444555406;6514.120593719977;6526.836829079121;6558.245801732671;6503.804885853432;6555.934440655723;6656.400923916871;6659.7003134860015;6713.865722685421;6293.685315734287;6310.716017779119;6377.553571249968;6414.230292364946;6422.3577642235405 16:49:10 INFO - PID 824 | |5;yui.html;883.50082203555;886.5301390263163;901.6393442622953;910.2217603948619;917.0737555069378;18842;19620.215191392344;19661.901690491562;19696.507587310323;19718;14637.341319640615;19720.506987325323;20609.27867524637;20620.278290259845;20769.688454673193;988.5946761827652;997.4912794474834;997.6059456514672;999.6801023672427;1001.0340021878885;988.8961659025806;993.6720882108923;993.8409854423257;1007.2395341517181;1007.5516395204137;942.1614762861025;1022.6829682798357;1036.6009086501676;1039.5581877701984;1053.4048262731571;1019.4545917933907;1023.4268809466722;1028.326446177751;1029.8249297619423;1029.917606591471;744.2631794523437;744.9180590135081;746.5259560179271;747.9439042071812;748.3078152708723;18419.263229470806;19239.711404328948;19498.220071197135;19519;19932.900335498376;20348.491287717927;20622.484437889023;21132.260370886946;21291;21438.464038399008;16460.917695411565;16778.328866845313;16827.158642067847;16944.15279236033;17018.48944531666;3664.4320130379833;3683.852645894161;3705.6850167735506;3705.981470092632;3708.517892673935;129264.35367823194;131649;133478.3326083373;135060;135883;15884.841151588336;15953.122578258308;16432.83567164337;16517.834821651628;16628.08545529983;28613.14160575186;29541;29651;29735.702642973727;29821.701782982327;8208.958955205186;8366.330693544502;8386.496810191407;8394.874076888851;8418.957905210556;4031.23406552754;4185.916281674349;4281.828726850953;4300.03249268912;4311.1377724454605;4425.468943726773;5097.898042039138;5260.815871444558;5273.815416460406;5280.3663560373;907.9727608171765;1052.2318707343682;1082.8484012238293;1092.5902786455079;1093.6445655162104;651.5829868883918;660.4023358860239;674.9055132281485;687.3435868745436;694.420159167091;11332.376719280519;11421.371824549564;12021.038316934624;12287.324197169062;12384.318862462651;652.451940370082;672.1161672400777;680.3026897430075;680.9182898052266;681.6387314723205;5460.399356070829;5588.3573389060775;5602.439756024446;5621.943780562142;5664.773409063674;114564.42717786357;116181.41909290399;119045;119486;121776.39111804384;94584;95836;97419;101103;104457;85338.14661853426;88658.55670721734;88802.70674136557;90146.09853901509;91761;12885.291308978096;13245.20528768277;13347.799783003456;13348.799768003293;13451.46194152223;39468.013299667735;40191.79904100461;40214.1957160861;40338.596614033486;40472.19055618812;52361;52840.20739688985;53046;53373;53933.19100213421;17553.473395798148;17782.91108544501;17798.110094494965;17830.554236143682;17901.19444624969;19582.706259406405;19883.40349789451;19921.800781991995;19943.202271908962;20079.096440660498;18652.626947461245;18661.90669046646;18704.53238669044;18908.243670253036;18960.146793394055;12032.458539365574;12195;12220.388980550759;12252.571160009356;12289;17929.73105403394;18024.2790288387;18191.090445477937;18212.089395530435;18675.43973680792;12205.084618653815;12640.87359126397;12681;12961.546345877849;13407.128536645087;13793.586192414243;14048.367823447765;14925.92537037308;15025.699486010437;15220.923895380894 16:49:10 INFO - PID 824 | __end_tp_report 16:49:10 INFO - PID 824 | __start_cc_report 16:49:10 INFO - PID 824 | _x_x_mozilla_cycle_collect,370 16:49:10 INFO - PID 824 | __end_cc_report 16:49:10 INFO - PID 824 | __startTimestamp1504050550126__endTimestamp 16:49:10 INFO - PID 824 | 16:49:10 INFO - PID 824 | ------- Summary: start ------- 16:49:10 INFO - PID 824 | Number of tests: 6 16:49:10 INFO - PID 824 | 16:49:10 INFO - PID 824 | [#0] dojo.html Cycles:165 Average:6174.47 Median:6417.58 stddev:707.63 (11.0%) stddev-sans-first:671.73 16:49:10 INFO - PID 824 | Values: 3255.6 3278.2 3292.8 3319.6 3348.4 6153.2 6327.3 6346.7 6347.8 6398.9 6089.8 6175.8 6193.6 6202.6 6214.1 5701.9 5770.7 5779.2 5784.1 5792.4 5762.9 5813.0 5832.2 5832.8 5842.2 5765.1 5825.4 5878.7 5896.4 5912.2 5799.6 5832.1 5841.4 5881.1 5934.3 5675.0 5784.7 5861.5 5880.1 5907.7 5539.1 6030.4 6125.6 6144.3 6171.2 6685.6 6712.4 6776.9 6807.7 6826.2 6562.7 6784.1 6796.3 6872.2 6874.1 6209.4 6215.7 6217.4 6221.9 6243.7 6827.1 6873.6 6874.6 6874.7 6882.9 6495.2 6529.6 6536.2 6542.2 6542.3 6733.1 6757.0 6757.4 6767.7 6775.2 6338.6 6609.1 6710.6 6719.2 6752.1 6706.9 6712.8 6798.3 6801.6 6811.6 5191.7 5277.6 5291.7 5294.7 5302.1 4660.1 4689.6 4718.3 4747.3 4766.5 5821.5 5835.1 5926.9 5931.0 5934.0 6577.6 6707.3 6711.7 6715.7 6812.0 5767.3 5772.7 5793.9 5810.3 5812.1 5754.1 5757.6 5777.7 5780.1 5781.9 6339.9 6350.5 6404.9 6434.1 6446.2 6581.6 6623.1 6632.8 6758.0 6815.8 6484.9 6491.5 6529.4 6572.8 6593.9 6423.3 6524.3 6618.2 6644.4 6721.9 6657.1 6698.4 6729.4 6740.3 6777.8 6547.5 6549.7 6586.4 6605.7 6612.3 6447.1 6475.6 6562.4 6575.1 6577.6 6417.6 6421.4 6462.5 6516.0 6522.0 6426.8 6472.5 6615.7 6659.8 6718.4 6163.5 6232.4 6251.4 6477.4 6498.2 16:49:10 INFO - PID 824 | 16:49:10 INFO - PID 824 | [#1] ext.html Cycles:180 Average:37051.92 Median:33035.59 stddev:55802.82 (168.9%) stddev-sans-first:55892.98 16:49:10 INFO - PID 824 | Values: 801.1 825.2 832.1 865.9 876.9 38049.6 39160.6 39203.2 39472.6 39670.4 35992.8 36058.0 36216.0 36402.8 36508.5 6775.7 6844.8 6877.7 6916.4 6954.2 6856.1 6938.5 6942.7 6944.5 6952.7 6873.9 6908.0 6928.2 7458.4 7805.6 7680.2 7686.6 7687.9 7740.5 7761.8 7559.9 7638.2 7653.0 7654.8 7655.0 35405.1 35947.8 36058.1 36201.5 36227.0 3470.3 3482.7 3495.1 3501.7 3522.1 30512.2 30513.5 30579.4 30689.4 30698.7 4999.5 5013.9 5120.8 5134.3 5246.3 187727.0 190566.0 190637.0 208522.0 213845.0 44490.0 44913.8 44927.8 45057.8 45060.5 46017.3 46151.5 46257.5 46525.3 46612.1 15276.3 15626.1 15661.8 15723.1 15948.6 13240.4 13389.5 13393.8 13395.3 13405.7 13006.3 13076.4 13083.7 13097.7 13141.2 5458.6 5476.6 5526.5 5587.7 5639.7 997.4 1005.6 1012.3 1016.3 1024.6 22257.3 22417.0 22623.4 22740.2 22999.2 1071.4 1101.8 1104.5 1106.5 1122.7 11846.6 11967.8 11997.5 12060.0 15420.2 232847.0 233746.0 234411.0 235355.0 235399.0 50609.5 50715.5 50736.7 50741.5 50823.7 1366.9 1426.5 1426.5 1434.3 1441.5 25897.6 25958.5 25989.5 25990.7 26292.0 30381.4 33684.3 34936.8 34940.3 34961.7 209570.0 210876.0 211743.0 211788.0 212108.0 27336.7 27706.2 27848.2 29749.7 31196.2 38944.2 38968.8 39075.0 39188.8 39682.8 29565.4 30039.4 30118.8 30201.8 30214.7 29204.6 29347.1 29380.3 29599.1 29779.4 32993.3 33077.8 35686.6 36565.5 36606.5 27431.5 27845.1 27942.4 28354.4 28555.4 23435.8 23570.4 23778.4 23944.0 24004.2 16:49:10 INFO - PID 824 | 16:49:10 INFO - PID 824 | [#2] jquery.html Cycles:180 Average:33540.77 Median:12257.97 stddev:79076.04 (645.1%) stddev-sans-first:79259.07 16:49:10 INFO - PID 824 | Values: 548.3 559.5 560.4 561.4 582.2 21210.7 21796.1 21809.7 21893.6 22466.2 22885.5 23241.3 23340.1 23399.9 23511.9 6607.6 6736.9 6743.6 6758.7 6765.9 5943.1 6576.9 6623.8 6629.8 6636.0 6484.7 6523.1 6532.2 6532.9 6539.1 6470.9 6533.3 6548.9 6549.9 6556.0 6068.8 6070.9 6073.5 6084.7 6088.4 28821.3 29866.6 30194.2 30554.9 30908.8 2025.6 2040.6 2045.5 2052.9 2065.0 19179.0 19684.5 19766.1 19781.4 19893.3 2182.7 2228.6 2242.2 2337.7 2518.9 130931.0 134598.0 135580.3 135628.3 136083.0 14268.1 14437.1 14674.9 14912.7 14950.6 22952.3 22962.0 23002.5 23084.5 23161.2 10214.1 10395.2 10433.2 10491.5 10577.5 9717.0 9729.2 9763.2 9920.3 9948.2 8789.7 8846.5 8976.2 9016.7 9383.7 2593.9 2618.7 2705.2 2733.5 2738.5 948.3 975.3 975.4 983.9 990.6 19254.3 19503.1 19522.0 19551.8 20072.9 1038.7 1047.4 1066.7 1073.2 1076.7 10508.2 10865.0 10885.5 11019.2 11083.4 464376.0 466005.0 466337.0 468359.0 482967.0 104904.5 107569.0 107660.5 108286.5 109470.0 1173.1 1195.7 1202.1 1204.2 1209.3 17095.9 17254.0 17420.2 17756.1 17994.6 54255.7 54881.2 55484.7 55684.7 56398.7 66968.3 67051.7 67144.3 67284.3 68314.7 14034.7 14195.8 14276.0 14289.6 14359.4 22287.3 22746.7 22866.3 22885.9 22897.7 17826.6 17996.6 18143.6 18241.2 18241.4 16002.4 16404.0 16646.2 17202.7 17222.7 17186.6 17208.0 17260.3 17388.0 17557.6 13544.8 13854.0 14089.2 14246.7 14269.8 16998.4 17000.2 17069.7 17123.6 17170.4 16:49:10 INFO - PID 824 | 16:49:10 INFO - PID 824 | [#3] mootools.html Cycles:180 Average:9039.98 Median:2615.11 stddev:6361.78 (243.3%) stddev-sans-first:6353.21 16:49:10 INFO - PID 824 | Values: 1323.8 1360.4 1394.4 1402.1 1408.2 14409.9 14944.7 15027.5 15032.6 15160.1 13689.6 14264.1 14548.4 14603.4 14646.0 2699.8 2778.4 2799.7 2801.1 2804.2 2608.6 2660.5 2727.1 2743.0 2745.8 2725.8 2748.8 2752.8 2753.4 2759.5 2618.5 2650.8 2653.5 2683.8 2697.1 2611.7 2626.1 2645.6 2647.0 2647.3 14100.6 14359.9 14427.4 14465.1 14466.5 7866.5 8165.1 8172.4 8197.8 8205.0 5280.5 5296.4 5320.8 5460.6 5603.1 1871.8 1875.1 1894.6 1896.2 1936.7 25010.2 25272.7 25296.9 25309.6 25340.4 6500.0 6660.7 6806.4 6857.2 6877.4 16425.8 16499.8 16523.8 16527.8 16675.4 7450.1 7454.1 7467.8 7503.5 7523.1 6793.5 6865.9 6946.2 7024.3 7024.5 5081.3 5285.0 5317.9 5334.7 5366.2 1429.0 1456.9 1509.9 1530.6 1538.3 870.1 881.6 892.9 909.1 909.5 7301.9 7327.1 7350.4 8430.3 8849.2 997.7 1002.5 1006.6 1015.4 1020.1 4903.6 5055.7 5093.9 5110.4 5165.7 20095.1 20095.6 20930.3 20976.4 20980.3 19582.3 20895.6 20965.6 21021.9 21137.6 10730.4 11256.2 11424.0 11434.0 11437.7 8153.0 8430.2 8475.6 8491.7 8494.7 17598.7 17867.6 18054.7 18158.5 18317.4 17768.0 17789.6 17820.2 18374.9 19203.2 11330.8 11430.3 11546.9 11552.2 11568.7 12827.6 13280.6 13548.3 13642.2 13655.2 10866.6 11027.5 11132.6 11172.3 11258.9 10843.1 10911.8 11268.4 11342.4 11360.5 8431.5 8444.7 8496.3 8508.4 8535.3 6997.2 7022.6 7065.4 7068.6 7069.0 7072.2 7131.3 7144.4 7204.3 7228.3 16:49:10 INFO - PID 824 | 16:49:10 INFO - PID 824 | [#4] prototype.html Cycles:180 Average:5538.91 Median:6186.05 stddev:1574.76 (25.5%) stddev-sans-first:1532.15 16:49:10 INFO - PID 824 | Values: 449.6 485.5 486.8 495.6 530.2 6006.7 6242.6 6314.4 6353.7 6417.8 6181.7 6190.4 6218.3 6226.5 6279.0 4891.5 4906.3 4955.3 4969.5 4988.0 4801.3 4932.9 4950.7 4960.6 4962.4 4902.0 4931.9 4944.1 4953.7 4990.8 4912.1 4912.6 4941.3 4944.6 4954.0 4405.7 4419.9 4429.7 4453.4 4455.9 6142.3 6149.3 6159.7 6174.0 6200.7 5644.3 5650.7 5657.2 5679.3 5702.0 6606.8 6675.7 6678.0 6681.8 6692.0 4825.4 4827.5 4827.9 4849.9 4890.1 6861.4 6866.2 6911.7 6947.4 7045.5 5034.3 5043.3 5049.1 5052.7 5059.6 5000.4 5105.1 5121.5 5129.4 5139.9 5586.9 5629.4 5655.2 5669.3 5676.7 6553.2 6567.3 6620.2 6659.4 6697.6 1671.5 1699.6 1705.9 1728.4 1752.9 1199.2 1200.9 1230.4 1231.6 1236.5 5725.8 5787.6 5790.1 5806.3 5858.6 6485.6 6836.7 6836.7 6859.4 6880.5 5785.2 5846.3 5864.9 5884.9 5908.8 3555.7 3603.9 3612.4 3632.4 3645.5 6522.4 6527.5 6570.1 6576.0 6583.5 6983.5 7012.8 7017.6 7040.4 7042.4 6475.3 6490.4 6603.6 6644.8 6659.2 6730.1 6766.2 6800.4 6833.6 6859.4 6708.8 6717.3 6744.8 6752.4 6800.0 6502.2 6502.9 6599.9 6606.5 6659.8 4952.9 4957.4 4985.6 4990.6 4995.7 6699.5 6703.0 6745.6 6828.2 6833.2 6366.4 6503.4 6573.2 6603.6 6634.4 6428.3 6576.2 6577.6 6627.0 6697.0 6409.0 6464.6 6514.1 6526.8 6558.2 6503.8 6555.9 6656.4 6659.7 6713.9 6293.7 6310.7 6377.6 6414.2 6422.4 16:49:10 INFO - PID 824 | 16:49:10 INFO - PID 824 | [#5] yui.html Cycles:180 Average:23559.59 Median:19902.60 stddev:33090.59 (166.3%) stddev-sans-first:33139.61 16:49:10 INFO - PID 824 | Values: 883.5 886.5 901.6 910.2 917.1 18842.0 19620.2 19661.9 19696.5 19718.0 14637.3 19720.5 20609.3 20620.3 20769.7 988.6 997.5 997.6 999.7 1001.0 988.9 993.7 993.8 1007.2 1007.6 942.2 1022.7 1036.6 1039.6 1053.4 1019.5 1023.4 1028.3 1029.8 1029.9 744.3 744.9 746.5 747.9 748.3 18419.3 19239.7 19498.2 19519.0 19932.9 20348.5 20622.5 21132.3 21291.0 21438.5 16460.9 16778.3 16827.2 16944.2 17018.5 3664.4 3683.9 3705.7 3706.0 3708.5 129264.4 131649.0 133478.3 135060.0 135883.0 15884.8 15953.1 16432.8 16517.8 16628.1 28613.1 29541.0 29651.0 29735.7 29821.7 8209.0 8366.3 8386.5 8394.9 8419.0 4031.2 4185.9 4281.8 4300.0 4311.1 4425.5 5097.9 5260.8 5273.8 5280.4 908.0 1052.2 1082.8 1092.6 1093.6 651.6 660.4 674.9 687.3 694.4 11332.4 11421.4 12021.0 12287.3 12384.3 652.5 672.1 680.3 680.9 681.6 5460.4 5588.4 5602.4 5621.9 5664.8 114564.4 116181.4 119045.0 119486.0 121776.4 94584.0 95836.0 97419.0 101103.0 104457.0 85338.1 88658.6 88802.7 90146.1 91761.0 12885.3 13245.2 13347.8 13348.8 13451.5 39468.0 40191.8 40214.2 40338.6 40472.2 52361.0 52840.2 53046.0 53373.0 53933.2 17553.5 17782.9 17798.1 17830.6 17901.2 19582.7 19883.4 19921.8 19943.2 20079.1 18652.6 18661.9 18704.5 18908.2 18960.1 12032.5 12195.0 12220.4 12252.6 12289.0 17929.7 18024.3 18191.1 18212.1 18675.4 12205.1 12640.9 12681.0 12961.5 13407.1 13793.6 14048.4 14925.9 15025.7 15220.9 16:49:10 INFO - PID 824 | -------- Summary: end -------- 16:49:10 INFO - PID 824 | 16:49:11 INFO - TEST-INFO | 824: exit 0 16:49:11 INFO - TEST-OK | dromaeo_css | took 1116350ms 16:49:11 INFO - TEST-START | kraken 16:49:11 INFO - Initialising browser for kraken test... 16:49:11 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:54155/getInfo.html -profile /tmp/tmpyMDEPF/profile 16:49:11 INFO - TEST-INFO | started process 1224 (/builds/slave/test/build/application/firefox/firefox http://localhost:54155/getInfo.html) 16:49:17 INFO - TEST-INFO | 1224: exit 0 16:49:17 INFO - Browser initialized. 16:49:17 INFO - Running cycle 1/1 for kraken test... 16:49:17 INFO - Using env: {'DISPLAY': ':0', 16:49:17 INFO - 'HOME': '/home/cltbld', 16:49:17 INFO - 'JSGC_DISABLE_POISONING': '1', 16:49:17 INFO - 'LANG': 'en_US.UTF-8', 16:49:17 INFO - 'LANGUAGE': 'en_US:en', 16:49:17 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 16:49:17 INFO - 'LOGNAME': 'cltbld', 16:49:17 INFO - 'MAIL': '/var/mail/cltbld', 16:49:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:49:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:49:17 INFO - 'MOZ_ACCELERATED': '1', 16:49:17 INFO - 'MOZ_CRASHREPORTER': '1', 16:49:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:49:17 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 16:49:17 INFO - 'MOZ_NO_REMOTE': '1', 16:49:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:49:17 INFO - 'MOZ_WEBRENDER': '1', 16:49:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:49:17 INFO - 'NO_EM_RESTART': '1', 16:49:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:49:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:49:17 INFO - 'PWD': '/builds/slave/test', 16:49:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:49:17 INFO - 'RUST_BACKTRACE': 'full', 16:49:17 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:49:17 INFO - 'SHELL': '/bin/bash', 16:49:17 INFO - 'SHLVL': '1', 16:49:17 INFO - 'TERM': 'linux', 16:49:17 INFO - 'TMOUT': '86400', 16:49:17 INFO - 'USER': 'cltbld', 16:49:17 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1504042539.837449-895384914', 16:49:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:49:17 INFO - '_': '/tools/buildbot/bin/python'} 16:49:17 INFO - TEST-INFO | started process 1487 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyMDEPF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:49:18 INFO - PID 1487 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 16:49:18 INFO - PID 1487 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 16:49:18 INFO - PID 1487 | 16:49:18 INFO - PID 1487 | (/builds/slave/test/build/application/firefox/firefox:1549): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:49:18 INFO - PID 1487 | 16:49:29 INFO - PID 1487 | RSS: Main: 204095488 16:49:29 INFO - PID 1487 | 16:49:31 INFO - PID 1487 | Cycle 1(1): loaded http://localhost:54155/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54155/tests/kraken/driver.html?testName=audio-beat-detection) 16:49:32 INFO - PID 1487 | RSS: Main: 211673088 16:49:32 INFO - PID 1487 | 16:49:35 INFO - PID 1487 | Cycle 1(1): loaded http://localhost:54155/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54155/tests/kraken/driver.html?testName=audio-dft) 16:49:36 INFO - PID 1487 | RSS: Main: 211292160 16:49:36 INFO - PID 1487 | 16:49:39 INFO - PID 1487 | Cycle 1(1): loaded http://localhost:54155/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54155/tests/kraken/driver.html?testName=audio-fft) 16:49:39 INFO - PID 1487 | RSS: Main: 204214272 16:49:39 INFO - PID 1487 | 16:49:42 INFO - PID 1487 | Cycle 1(1): loaded http://localhost:54155/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54155/tests/kraken/driver.html?testName=audio-oscillator) 16:49:42 INFO - PID 1487 | RSS: Main: 206385152 16:49:42 INFO - PID 1487 | 16:49:44 INFO - PID 1487 | Cycle 1(1): loaded http://localhost:54155/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54155/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:49:45 INFO - PID 1487 | RSS: Main: 206540800 16:49:45 INFO - PID 1487 | 16:49:48 INFO - PID 1487 | Cycle 1(1): loaded http://localhost:54155/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54155/tests/kraken/driver.html?testName=imaging-darkroom) 16:49:49 INFO - PID 1487 | RSS: Main: 208289792 16:49:49 INFO - PID 1487 | 16:49:52 INFO - PID 1487 | Cycle 1(1): loaded http://localhost:54155/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54155/tests/kraken/driver.html?testName=imaging-desaturate) 16:49:53 INFO - PID 1487 | RSS: Main: 206839808 16:49:53 INFO - PID 1487 | 16:49:56 INFO - PID 1487 | Cycle 1(1): loaded http://localhost:54155/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54155/tests/kraken/driver.html?testName=json-parse-financial) 16:49:57 INFO - PID 1487 | RSS: Main: 207749120 16:49:57 INFO - PID 1487 | 16:49:58 INFO - PID 1487 | Cycle 1(1): loaded http://localhost:54155/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54155/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:49:59 INFO - PID 1487 | RSS: Main: 208265216 16:49:59 INFO - PID 1487 | 16:50:00 INFO - PID 1487 | Cycle 1(1): loaded http://localhost:54155/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54155/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:50:01 INFO - PID 1487 | RSS: Main: 206831616 16:50:01 INFO - PID 1487 | 16:50:03 INFO - PID 1487 | Cycle 1(1): loaded http://localhost:54155/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54155/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:50:04 INFO - PID 1487 | RSS: Main: 206123008 16:50:04 INFO - PID 1487 | 16:50:07 INFO - PID 1487 | Cycle 1(1): loaded http://localhost:54155/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54155/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:50:07 INFO - PID 1487 | RSS: Main: 206565376 16:50:07 INFO - PID 1487 | 16:50:10 INFO - PID 1487 | Cycle 1(1): loaded http://localhost:54155/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54155/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:50:11 INFO - PID 1487 | RSS: Main: 205721600 16:50:11 INFO - PID 1487 | 16:50:13 INFO - PID 1487 | Cycle 1(1): loaded http://localhost:54155/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54155/tests/kraken/driver.html?testName=ai-astar) 16:50:13 INFO - PID 1487 | RSS: Main: 208543744 16:50:13 INFO - PID 1487 | 16:50:13 INFO - PID 1487 | __start_tp_report 16:50:13 INFO - PID 1487 | _x_x_mozilla_page_load 16:50:13 INFO - PID 1487 | _x_x_mozilla_page_load_details 16:50:13 INFO - PID 1487 | |i|pagename|runs| 16:50:13 INFO - PID 1487 | |0;ai-astar;97;108;108;110;119;114;113;101;109;110 16:50:13 INFO - PID 1487 | |1;audio-beat-detection;157;121;153;179;123;150;155;130;173;126 16:50:13 INFO - PID 1487 | |2;audio-dft;164;162;164;165;171;165;166;186;163;163 16:50:13 INFO - PID 1487 | |3;audio-fft;94;76;76;167;76;77;79;74;166;76 16:50:13 INFO - PID 1487 | |4;audio-oscillator;88;79;137;80;84;79;132;82;79;133 16:50:13 INFO - PID 1487 | |5;imaging-gaussian-blur;115;123;114;120;114;114;114;114;113;117 16:50:13 INFO - PID 1487 | |6;imaging-darkroom;151;149;152;150;148;149;152;148;154;148 16:50:13 INFO - PID 1487 | |7;imaging-desaturate;97;95;104;95;95;107;96;99;94;95 16:50:13 INFO - PID 1487 | |8;json-parse-financial;55;52;52;60;52;52;54;56;52;53 16:50:13 INFO - PID 1487 | |9;json-stringify-tinderbox;37;46;49;41;39;37;38;37;45;37 16:50:13 INFO - PID 1487 | |10;stanford-crypto-aes;81;79;75;76;75;86;79;76;76;87 16:50:13 INFO - PID 1487 | |11;stanford-crypto-ccm;135;126;123;121;127;127;129;123;125;163 16:50:13 INFO - PID 1487 | |12;stanford-crypto-pbkdf2;170;172;170;162;203;172;182;168;181;170 16:50:13 INFO - PID 1487 | |13;stanford-crypto-sha256-iterative;68;63;65;64;67;67;63;64;66;65 16:50:13 INFO - PID 1487 | __end_tp_report 16:50:13 INFO - PID 1487 | __start_cc_report 16:50:13 INFO - PID 1487 | _x_x_mozilla_cycle_collect,936 16:50:13 INFO - PID 1487 | __end_cc_report 16:50:13 INFO - PID 1487 | __startTimestamp1504050613564__endTimestamp 16:50:13 INFO - PID 1487 | 16:50:13 INFO - PID 1487 | ------- Summary: start ------- 16:50:13 INFO - PID 1487 | Number of tests: 14 16:50:13 INFO - PID 1487 | 16:50:13 INFO - PID 1487 | [#0] ai-astar Cycles:10 Average:108.90 Median:111.50 stddev:6.26 (5.6%) stddev-sans-first:4.94 16:50:13 INFO - PID 1487 | Values: 97.0 108.0 108.0 110.0 119.0 114.0 113.0 101.0 109.0 110.0 16:50:13 INFO - PID 1487 | 16:50:13 INFO - PID 1487 | [#1] audio-beat-detection Cycles:10 Average:146.70 Median:154.00 stddev:20.79 (13.5%) stddev-sans-first:21.71 16:50:13 INFO - PID 1487 | Values: 157.0 121.0 153.0 179.0 123.0 150.0 155.0 130.0 173.0 126.0 16:50:13 INFO - PID 1487 | 16:50:13 INFO - PID 1487 | [#2] audio-dft Cycles:10 Average:166.90 Median:165.00 stddev:7.16 (4.3%) stddev-sans-first:7.51 16:50:13 INFO - PID 1487 | Values: 164.0 162.0 164.0 165.0 171.0 165.0 166.0 186.0 163.0 163.0 16:50:13 INFO - PID 1487 | 16:50:13 INFO - PID 1487 | [#3] audio-fft Cycles:10 Average:96.10 Median:76.00 stddev:37.53 (49.4%) stddev-sans-first:39.80 16:50:13 INFO - PID 1487 | Values: 94.0 76.0 76.0 167.0 76.0 77.0 79.0 74.0 166.0 76.0 16:50:13 INFO - PID 1487 | 16:50:13 INFO - PID 1487 | [#4] audio-oscillator Cycles:10 Average:97.30 Median:79.50 stddev:25.51 (32.1%) stddev-sans-first:26.83 16:50:13 INFO - PID 1487 | Values: 88.0 79.0 137.0 80.0 84.0 79.0 132.0 82.0 79.0 133.0 16:50:13 INFO - PID 1487 | 16:50:13 INFO - PID 1487 | [#5] imaging-gaussian-blur Cycles:10 Average:115.80 Median:114.50 stddev:3.26 (2.8%) stddev-sans-first:3.44 16:50:13 INFO - PID 1487 | Values: 115.0 123.0 114.0 120.0 114.0 114.0 114.0 114.0 113.0 117.0 16:50:13 INFO - PID 1487 | 16:50:13 INFO - PID 1487 | [#6] imaging-darkroom Cycles:10 Average:150.10 Median:150.50 stddev:2.08 (1.4%) stddev-sans-first:2.18 16:50:13 INFO - PID 1487 | Values: 151.0 149.0 152.0 150.0 148.0 149.0 152.0 148.0 154.0 148.0 16:50:13 INFO - PID 1487 | 16:50:13 INFO - PID 1487 | [#7] imaging-desaturate Cycles:10 Average:97.70 Median:95.00 stddev:4.40 (4.6%) stddev-sans-first:4.66 16:50:13 INFO - PID 1487 | Values: 97.0 95.0 104.0 95.0 95.0 107.0 96.0 99.0 94.0 95.0 16:50:13 INFO - PID 1487 | 16:50:13 INFO - PID 1487 | [#8] json-parse-financial Cycles:10 Average:53.80 Median:53.50 stddev:2.62 (4.9%) stddev-sans-first:2.74 16:50:13 INFO - PID 1487 | Values: 55.0 52.0 52.0 60.0 52.0 52.0 54.0 56.0 52.0 53.0 16:50:13 INFO - PID 1487 | 16:50:13 INFO - PID 1487 | [#9] json-stringify-tinderbox Cycles:10 Average:40.60 Median:40.00 stddev:4.48 (11.2%) stddev-sans-first:4.56 16:50:13 INFO - PID 1487 | Values: 37.0 46.0 49.0 41.0 39.0 37.0 38.0 37.0 45.0 37.0 16:50:13 INFO - PID 1487 | 16:50:13 INFO - PID 1487 | [#10] stanford-crypto-aes Cycles:10 Average:79.00 Median:79.00 stddev:4.42 (5.6%) stddev-sans-first:4.63 16:50:13 INFO - PID 1487 | Values: 81.0 79.0 75.0 76.0 75.0 86.0 79.0 76.0 76.0 87.0 16:50:13 INFO - PID 1487 | 16:50:13 INFO - PID 1487 | [#11] stanford-crypto-ccm Cycles:10 Average:129.90 Median:127.00 stddev:12.26 (9.7%) stddev-sans-first:12.86 16:50:13 INFO - PID 1487 | Values: 135.0 126.0 123.0 121.0 127.0 127.0 129.0 123.0 125.0 163.0 16:50:13 INFO - PID 1487 | 16:50:13 INFO - PID 1487 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.00 Median:172.00 stddev:11.45 (6.7%) stddev-sans-first:12.00 16:50:13 INFO - PID 1487 | Values: 170.0 172.0 170.0 162.0 203.0 172.0 182.0 168.0 181.0 170.0 16:50:13 INFO - PID 1487 | 16:50:13 INFO - PID 1487 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.20 Median:65.50 stddev:1.75 (2.7%) stddev-sans-first:1.54 16:50:13 INFO - PID 1487 | Values: 68.0 63.0 65.0 64.0 67.0 67.0 63.0 64.0 66.0 65.0 16:50:13 INFO - PID 1487 | -------- Summary: end -------- 16:50:13 INFO - PID 1487 | 16:50:14 INFO - PID 1487 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 16:50:14 INFO - TEST-INFO | 1487: exit 0 16:50:14 INFO - TEST-OK | kraken | took 63328ms 16:50:14 INFO - SUITE-END | took 1179s 16:50:14 INFO - Completed test suite (00:19:39) 16:50:14 INFO - javascript benchmark 16:50:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8407.948310941358, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3255.560499332589, 3278.1968417737644, 3292.835358232088, 3319.5684561007065, 3348.4475061614835, 6153.16932214151, 6327.272363678178, 6346.746130154788, 6347.8413039673915, 6398.936010639893, 6089.817305480843, 6175.845603859906, 6193.566450348466, 6202.565820392574, 6214.130021796952, 5701.885962280752, 5770.740316685759, 5779.190913272145, 5784.103463963072, 5792.420757924216, 5762.855928601776, 5812.970935145339, 5832.212651292085, 5832.766689332421, 5842.21130147431, 5765.077587585987, 5825.388334224909, 5878.735456904449, 5896.380880007602, 5912.17229587858, 5799.594028418012, 5832.096025116092, 5841.4450627190345, 5881.117832325164, 5934.317553481362, 5674.971625141848, 5784.652920824764, 5861.501772349356, 5880.117982302646, 5907.704614769287, 5539.120825028839, 6030.366811484775, 6125.601835880653, 6144.262688477366, 6171.197744293213, 6685.632290224035, 6712.362325579063, 6776.898346524757, 6807.727690892359, 6826.214985276707, 6562.704678289489, 6784.050232967388, 6796.286389929085, 6872.209695884987, 6874.140732408449, 6209.410106039919, 6215.720292586844, 6217.378262173792, 6221.87556248877, 6243.719032643542, 6827.112475378169, 6873.553219040747, 6874.621895795779, 6874.690638921161, 6882.931170688329, 6495.1556297681, 6529.608223506605, 6536.215654121441, 6542.214934207926, 6542.34576542342, 6733.124693789776, 6756.966215168893, 6757.425618822357, 6767.661616919135, 6775.1531058617675, 6338.556301058974, 6609.1077704510235, 6710.597364158069, 6719.160104986877, 6752.122224110834, 6706.865862682719, 6712.798616041527, 6798.320167983162, 6801.591904485746, 6811.625360605214, 5191.688498690015, 5277.577793776489, 5291.656042357312, 5294.7352632369, 5302.125149350314, 4660.067986402665, 4689.648276379286, 4718.3158442025715, 4747.335373047776, 4766.451858036301, 5821.476067153976, 5835.124731290255, 5926.911096333559, 5930.970345148333, 5933.970330148408, 6577.6053436793945, 6707.262201157869, 6711.7315307388135, 6715.6977935993, 6812.046313516112, 5767.279090113736, 5772.711364431846, 5793.942060579425, 5810.331811841608, 5812.099124635688, 5754.108113242454, 5757.596968212185, 5777.711114444261, 5780.075187969988, 5781.942180578225, 6339.873202535923, 6350.491960643138, 6404.871902562016, 6434.131392262078, 6446.194225721785, 6581.605103693793, 6623.105880706043, 6632.801015969529, 6758.0, 6815.795526134224, 6484.935150648622, 6491.545591808717, 6529.412352888263, 6572.76995305162, 6593.901091483535, 6423.261324947691, 6524.282328943717, 6618.172728408949, 6644.435223006099, 6721.932780672326, 6657.06801047844, 6698.39714425704, 6729.427998619976, 6740.258571557027, 6777.830554235987, 6547.476201903741, 6549.705263263069, 6586.37429444202, 6605.702743376656, 6612.305707900794, 6447.129637498878, 6475.611463312216, 6562.409383155539, 6575.079488871466, 6577.572457790228, 6417.582857114273, 6421.389967953037, 6462.450691691259, 6515.967420162869, 6522.0, 6426.839329016812, 6472.482201423969, 6615.66921653925, 6659.766908158385, 6718.428933540704, 6163.476104531165, 6232.407921247474, 6251.4061164189325, 6477.384648458389, 6498.220213574401], "value": 6124.1953563407915, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [801.1307731111743, 825.1583384947351, 832.105486601903, 865.9220670139687, 876.8991565969916, 38049.619503804955, 39160.60839391609, 39203.21593568134, 39472.60527394729, 39670.40494392587, 35992.82003589985, 36058.0, 36216.0, 36402.817985910035, 36508.45237321442, 6775.728970841161, 6844.760433384808, 6877.656117194146, 6916.377526022657, 6954.200266969313, 6856.142982127234, 6938.514303998722, 6942.652867356637, 6944.47916406269, 6952.652367381636, 6873.896891546631, 6908.0, 6928.237893831674, 7458.440616953751, 7805.60971951403, 7680.155182929873, 7686.5772382518935, 7687.923120768776, 7740.496867703581, 7761.7671469855995, 7559.886601700924, 7638.159802421729, 7652.961735191288, 7654.770356889302, 7655.0, 35405.114872128404, 35947.82026089879, 36058.09854753652, 36201.456978145085, 36227.0, 3470.340635279314, 3482.6517348265224, 3495.1262184453885, 3501.7198624110265, 3522.1018640246575, 30512.237194070105, 30513.542296865566, 30579.388412231852, 30689.38621227585, 30698.693013069806, 4999.525045120708, 5013.924791128136, 5120.795168193268, 5134.2812006319145, 5246.31797866275, 187727.0, 190566.0, 190637.0, 208522.0, 213845.0, 44490.0, 44913.77543112264, 44927.77536112364, 45057.774711126236, 45060.54939450629, 46017.30974035392, 46151.53848461472, 46257.537424625996, 46525.30212046822, 46612.06775864464, 15276.312565934559, 15626.140562268956, 15661.843381566267, 15723.135227562594, 15948.601284967737, 13240.404181811842, 13389.531366402129, 13393.799093013613, 13395.330233488286, 13405.731885362433, 13006.349682516025, 13076.411561479756, 13083.738325233442, 13097.738045239043, 13141.211527308393, 5458.645188062763, 5476.616636835463, 5526.47498487643, 5587.720613969285, 5639.718014099279, 997.3517213811081, 1005.6379703306803, 1012.2863381316155, 1016.339379403379, 1024.6208902706046, 22257.332280031624, 22417.0, 22623.43441413945, 22740.20409285667, 22999.195028173934, 1071.3571856885806, 1101.8457415961611, 1104.5471356743697, 1106.4799544214206, 1122.6968718446137, 11846.585369512199, 11967.820482692767, 11997.460114294878, 12060.0, 15420.151891645843, 232847.0, 233746.0, 234411.0, 235355.0, 235399.0, 50609.493905061216, 50715.47853564399, 50736.74631626818, 50741.49258507442, 50823.745881270355, 1366.931653417345, 1426.5292453490324, 1426.5435060780658, 1434.2900264369205, 1441.4666573368131, 25897.611535827353, 25958.480830383665, 25989.480210395308, 25990.740092598833, 26292.0, 30381.392372152874, 33684.3263134731, 34936.825315873255, 34940.30119397547, 34961.65038349584, 209570.0, 210876.0, 211743.0, 211788.0, 212108.0, 27336.72663273342, 27706.168814935583, 27848.16455506338, 29749.702502974695, 31196.220094497818, 38944.2211155781, 38968.80515597404, 39075.0, 39188.80405597954, 39682.80158599304, 29565.408691826473, 30039.399212016073, 30118.84940575283, 30201.848990754905, 30214.69785302119, 29204.56193157147, 29347.119586412442, 29380.265493362836, 29599.112026639235, 29779.404411912074, 32993.34013319768, 33077.834610826794, 35686.64313356833, 36565.45151822778, 36606.45090323594, 27431.451370972867, 27845.050846441365, 27942.44115117727, 28354.43291134207, 28555.42889142164, 23435.76564234336, 23570.410739731644, 23778.40553986095, 23944.0, 24004.15985440501], "value": 16506.282772365674, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [548.3419896124649, 559.4657102467145, 560.3835780641298, 561.3684604819578, 582.1965687351455, 21210.6818397724, 21796.128154873804, 21809.67285490717, 21893.562128757414, 22466.213682521116, 22885.542289154208, 23241.30276091716, 23340.066397344086, 23399.883000584974, 23511.882440587815, 6607.570507916982, 6736.932630673679, 6743.629100399476, 6758.729650813962, 6765.898511522331, 5943.108533719934, 6576.934230657704, 6623.834404139911, 6629.8342541436605, 6635.966820165892, 6484.708188131545, 6523.054157147235, 6532.183477065367, 6532.869342613145, 6539.117219175422, 6470.935290647104, 6533.31400202979, 6548.9017664735065, 6549.901751473732, 6556.049372840959, 6068.757249710006, 6070.8785824283705, 6073.483753880925, 6084.665343406111, 6088.360722124202, 28821.27946801347, 29866.552001719992, 30194.24514387158, 30554.930577429684, 30908.845455772804, 2025.605007023631, 2040.6224848403092, 2045.5499790046167, 2052.9281475148446, 2065.029436165, 19179.0, 19684.50788730279, 19766.110525026408, 19781.40655780329, 19893.303734369372, 2182.694422780812, 2228.6099932511747, 2242.2040175737543, 2337.731160916482, 2518.8614626195554, 130931.0, 134598.0, 135580.3220983889, 135628.3218583901, 136083.0, 14268.14391136535, 14437.133771973715, 14674.853251467563, 14912.70174596502, 14950.551483455514, 22952.311430657108, 22962.0, 23002.539949200924, 23084.53830923372, 23161.189358372376, 10214.131798797036, 10395.16838652906, 10433.21750868688, 10491.475426228659, 10577.524011419504, 9716.95141524302, 9729.173020293354, 9763.170130538983, 9920.255980801468, 9948.154406875497, 8789.692360767342, 8846.513441760637, 8976.192142707188, 9016.684416045407, 9383.733196018587, 2593.9092131775674, 2618.738126187366, 2705.1613999660167, 2733.5079685656374, 2738.548139556951, 948.3314263444255, 975.3124047546463, 975.4342481360794, 983.9458829764432, 990.6334656177116, 19254.326098586484, 19503.122359493856, 19522.0, 19551.804481954998, 20072.89963550173, 1038.678009816959, 1047.3872784421199, 1066.6906597086759, 1073.2111897755144, 1076.6716151573846, 10508.159347252202, 10865.0, 10885.455727213608, 11019.228653994143, 11083.42529573608, 464376.0, 466005.0, 466337.0, 468359.0, 482967.0, 104904.47547762365, 107569.0, 107660.461697691, 108286.45856770666, 109470.0, 1173.1260211142583, 1195.7070517723214, 1202.0864143251192, 1204.1931905623253, 1209.2563073709605, 17095.91452042732, 17254.0, 17420.216090275713, 17756.11219438997, 17994.640107198044, 54255.72872135614, 54881.176782347495, 55484.72257638848, 55684.72157639186, 56398.718006409705, 66968.33031669621, 67051.66474167598, 67144.32855671381, 67284.32715672976, 68314.65842670755, 14034.719305613626, 14195.787063194268, 14276.0, 14289.571312860631, 14359.353829077925, 22287.331380058626, 22746.65880011768, 22866.31401057971, 22885.88557057204, 22897.65653515165, 17826.5543361417, 17996.640067198845, 18143.637127257116, 18241.179146938153, 18241.361552345603, 16002.439914602934, 16404.0, 16646.16769161513, 17202.65594688124, 17222.65554688874, 17186.570335741708, 17208.0, 17260.309587616353, 17388.0, 17557.561060973578, 13544.79682804739, 13854.03021788465, 14089.225092619594, 14246.715065698836, 14269.785953210503, 16998.405055822986, 17000.23498942526, 17069.743953840454, 17123.571910702332, 17170.39903603368], "value": 11771.561081651396, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1323.7617228898798, 1360.4354193009901, 1394.3585950462793, 1402.144691738039, 1408.2114016150956, 14409.927950360247, 14944.701105977874, 15027.549173524785, 15032.624184395396, 15160.09039457632, 13689.589312320646, 14264.0728352657, 14548.418063277457, 14603.415863365479, 14646.0, 2699.784017278613, 2778.3748656552216, 2799.7340252675963, 2801.089645865092, 2804.2008027712104, 2608.6478325426015, 2660.4546068056, 2727.1136880513914, 2743.0, 2745.766609838166, 2725.822821516595, 2748.7938404619636, 2752.8073034887566, 2753.435545713134, 2759.4619049285398, 2618.5205358972216, 2650.8011899107546, 2653.5223659741337, 2683.798715096356, 2697.109953715269, 2611.6996545397333, 2626.1071235779737, 2645.5899335603012, 2647.0, 2647.2984659065364, 14100.647483812883, 14359.856401435956, 14427.35076921541, 14465.05977111495, 14466.49367272151, 7866.528008319462, 8165.101838797727, 8172.427930044899, 8197.836043279161, 8205.0, 5280.498352656491, 5296.417394086686, 5320.760565774511, 5460.645058071253, 5603.075492543725, 1871.803460636627, 1875.1280654495588, 1894.5737209127974, 1896.1872310791734, 1936.66108431024, 25010.249692509253, 25272.747272527406, 25296.873515632305, 25309.62035569468, 25340.366490837692, 6499.967500162564, 6660.733570657217, 6806.353396427331, 6857.211420686585, 6877.3810357067105, 16425.753613695804, 16499.83500165007, 16523.83476165247, 16527.752083718755, 16675.416360427327, 7450.143233528105, 7454.142773580999, 7467.813304667318, 7503.512271702322, 7523.0972283326355, 6793.5244532882225, 6865.9313406866295, 6946.16646002483, 7024.297570242935, 7024.5434046786795, 5081.28861959326, 5285.048691235537, 5317.867053323698, 5334.733263336818, 5366.16824392212, 1428.9857101428852, 1456.9125852448888, 1509.9320530576151, 1530.5867415797672, 1538.3077615073262, 870.0820634230821, 881.6385282034463, 892.9151730585584, 909.0682050897883, 909.4952301472746, 7301.89047164293, 7327.120745510573, 7350.4119670426235, 8430.283425908867, 8849.20357167845, 997.7306127345721, 1002.5087707023506, 1006.6174853555748, 1015.4161357219629, 1020.1481762728057, 4903.632227582945, 5055.6713813602, 5093.898122037613, 5110.386753589519, 5165.690058596496, 20095.095720692603, 20095.598088038158, 20930.267440639505, 20976.37070887876, 20980.26569070075, 19582.31461898827, 20895.582088358453, 20965.580688386453, 21021.894890525757, 21137.577248454945, 10730.356178629307, 11256.21206515536, 11423.999999999834, 11434.02810761078, 11437.656870293904, 8152.959235203786, 8430.199131082538, 8475.57622118904, 8491.702790402307, 8494.660213591635, 17598.73601895947, 17867.553311167325, 18054.729179062062, 18158.45524634263, 18317.358892439235, 17768.0, 17789.555261118574, 17820.198091085673, 18374.908125459286, 19203.231870725573, 11330.830037549278, 11430.25703329281, 11546.94226528862, 11552.249103808226, 11568.710782230512, 12827.551035713705, 13280.601581952556, 13548.25484598317, 13642.181469111885, 13655.248961307223, 10866.61966831157, 11027.503762330874, 11132.610358637408, 11172.329660220414, 11258.943705281421, 10843.132549395872, 10911.836322455329, 11268.38023908693, 11342.432878356214, 11360.488778004845, 8431.536265505456, 8444.746657600283, 8496.320294376312, 8508.446950948168, 8535.31717462589, 6997.160340759141, 7022.613756243456, 7065.364117229474, 7068.646567671699, 7069.0, 7072.151341839012, 7131.322524360177, 7144.3570078693165, 7204.279572042754, 7228.349448549656], "value": 6536.65426764413, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [449.58638052991245, 485.5096352683788, 486.79797883878194, 495.5628676837173, 530.202045920889, 6006.669633170174, 6242.563020588561, 6314.40013198746, 6353.745850165988, 6417.839554011152, 6181.690915454232, 6190.409562453778, 6218.25380954285, 6226.474513744128, 6278.968605156979, 4891.5353041461, 4906.337644417994, 4955.306257123987, 4969.478204788499, 4987.975060124694, 4801.2798080287885, 4932.876678083041, 4950.653454258203, 4960.578350840165, 4962.379702537183, 4902.0, 4931.876703082434, 4944.110060189165, 4953.678010929296, 4990.800367985276, 4912.0597364041005, 4912.557869791736, 4941.308216849644, 4944.604431645478, 4954.0, 4405.713628614129, 4419.889502762425, 4429.712068715523, 4453.376527286183, 4455.910881782379, 6142.262928448615, 6149.262088549358, 6159.722812473449, 6173.981293086636, 6200.658963756991, 5644.266245388114, 5650.660960342392, 5657.179708942181, 5679.346875109332, 5701.971490142523, 6606.768763093317, 6675.699593518303, 6677.966610166966, 6681.832954176136, 6691.966540167316, 4825.396825396825, 4827.493113223131, 4827.879303017417, 4849.854504364839, 4890.095332363524, 6861.407952518682, 6866.244713081607, 6911.654417279166, 6947.3747362736585, 7045.506814522985, 5034.270030845507, 5043.319151914445, 5049.116404629175, 5052.72210028452, 5059.62052846038, 5000.399952005782, 5105.106606343949, 5121.513456221653, 5129.435522165701, 5139.948600514022, 5586.860328491739, 5629.352624448159, 5655.1517272409465, 5669.291338582677, 5676.744546495418, 6553.246376666649, 6567.343265673395, 6620.238672552622, 6659.367360100783, 6697.631630260285, 1671.5319710481085, 1699.5836020175136, 1705.9061751603533, 1728.4037007232484, 1752.9211185496429, 1199.220506670671, 1200.8799120088097, 1230.354064116346, 1231.599730087725, 1236.505397840871, 5725.77096916127, 5787.594868359259, 5790.131480277908, 5806.274215723035, 5858.589898707135, 6485.643289619116, 6836.658167091725, 6836.6923488443135, 6859.382655561023, 6880.518363714492, 5785.190073389729, 5846.269216347957, 5864.912026319608, 5884.852878677982, 5908.763649454059, 3555.6977656899453, 3603.873864414733, 3612.422012477991, 3632.3824949758605, 3645.4714066460747, 6522.412982831473, 6527.510436717265, 6570.113034740344, 6575.967120164369, 6583.473322134218, 6983.546069505466, 7012.824679383056, 7017.578945263199, 7040.401565866856, 7042.401395881408, 6475.255345635313, 6490.448311893542, 6603.636799975951, 6644.800655980328, 6659.234188068337, 6730.125083739278, 6766.1880574329425, 6800.387965083166, 6833.624150671761, 6859.416949559144, 6708.798736037927, 6717.328267173439, 6744.7976560703255, 6752.426043786333, 6799.966000170165, 6502.154719886385, 6502.869942601027, 6599.934000659932, 6606.504512161703, 6659.800205993828, 4952.925706114484, 4957.429895561912, 4985.554189285212, 4990.6007519397635, 4995.675281106716, 6699.459124401513, 6703.0, 6745.5952642841585, 6828.180618325634, 6833.248342682202, 6366.395192456709, 6503.414692677682, 6573.1783527059115, 6603.603783772797, 6634.436072933855, 6428.292887782433, 6576.210854697276, 6577.572457790228, 6626.966865165643, 6696.966515167393, 6408.967955160194, 6464.644444555406, 6514.120593719977, 6526.836829079121, 6558.245801732671, 6503.804885853432, 6555.934440655723, 6656.400923916871, 6659.7003134860015, 6713.865722685421, 6293.685315734287, 6310.716017779119, 6377.553571249968, 6414.230292364946, 6422.3577642235405], "value": 5067.958446382563, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [883.50082203555, 886.5301390263163, 901.6393442622953, 910.2217603948619, 917.0737555069378, 18842.0, 19620.215191392344, 19661.901690491562, 19696.507587310323, 19718.0, 14637.341319640615, 19720.506987325323, 20609.27867524637, 20620.278290259845, 20769.688454673193, 988.5946761827652, 997.4912794474834, 997.6059456514672, 999.6801023672427, 1001.0340021878885, 988.8961659025806, 993.6720882108923, 993.8409854423257, 1007.2395341517181, 1007.5516395204137, 942.1614762861025, 1022.6829682798357, 1036.6009086501676, 1039.5581877701984, 1053.4048262731571, 1019.4545917933907, 1023.4268809466722, 1028.326446177751, 1029.8249297619423, 1029.917606591471, 744.2631794523437, 744.9180590135081, 746.5259560179271, 747.9439042071812, 748.3078152708723, 18419.263229470806, 19239.711404328948, 19498.220071197135, 19519.0, 19932.900335498376, 20348.491287717927, 20622.484437889023, 21132.260370886946, 21291.0, 21438.464038399008, 16460.917695411565, 16778.328866845313, 16827.158642067847, 16944.15279236033, 17018.48944531666, 3664.4320130379833, 3683.852645894161, 3705.6850167735506, 3705.981470092632, 3708.517892673935, 129264.35367823194, 131649.0, 133478.3326083373, 135060.0, 135883.0, 15884.841151588336, 15953.122578258308, 16432.83567164337, 16517.834821651628, 16628.08545529983, 28613.14160575186, 29541.0, 29651.0, 29735.702642973727, 29821.701782982327, 8208.958955205186, 8366.330693544502, 8386.496810191407, 8394.874076888851, 8418.957905210556, 4031.23406552754, 4185.916281674349, 4281.828726850953, 4300.03249268912, 4311.1377724454605, 4425.468943726773, 5097.898042039138, 5260.815871444558, 5273.815416460406, 5280.3663560373, 907.9727608171765, 1052.2318707343682, 1082.8484012238293, 1092.5902786455079, 1093.6445655162104, 651.5829868883918, 660.4023358860239, 674.9055132281485, 687.3435868745436, 694.420159167091, 11332.376719280519, 11421.371824549564, 12021.038316934624, 12287.324197169062, 12384.318862462651, 652.451940370082, 672.1161672400777, 680.3026897430075, 680.9182898052266, 681.6387314723205, 5460.399356070829, 5588.3573389060775, 5602.439756024446, 5621.943780562142, 5664.773409063674, 114564.42717786357, 116181.41909290399, 119045.0, 119486.0, 121776.39111804384, 94584.0, 95836.0, 97419.0, 101103.0, 104457.0, 85338.14661853426, 88658.55670721734, 88802.70674136557, 90146.09853901509, 91761.0, 12885.291308978096, 13245.20528768277, 13347.799783003456, 13348.799768003293, 13451.46194152223, 39468.013299667735, 40191.79904100461, 40214.1957160861, 40338.596614033486, 40472.19055618812, 52361.0, 52840.20739688985, 53046.0, 53373.0, 53933.19100213421, 17553.473395798148, 17782.91108544501, 17798.110094494965, 17830.554236143682, 17901.19444624969, 19582.706259406405, 19883.40349789451, 19921.800781991995, 19943.202271908962, 20079.096440660498, 18652.626947461245, 18661.90669046646, 18704.53238669044, 18908.243670253036, 18960.146793394055, 12032.458539365574, 12195.0, 12220.388980550759, 12252.571160009356, 12289.0, 17929.73105403394, 18024.2790288387, 18191.090445477937, 18212.089395530435, 18675.43973680792, 12205.084618653815, 12640.87359126397, 12681.0, 12961.546345877849, 13407.128536645087, 13793.586192414243, 14048.367823447765, 14925.92537037308, 15025.699486010437, 15220.923895380894], "value": 8961.783966762743, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1523.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 108.0, 108.0, 110.0, 119.0, 114.0, 113.0, 101.0, 109.0, 110.0], "value": 108.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 121.0, 153.0, 179.0, 123.0, 150.0, 155.0, 130.0, 173.0, 126.0], "value": 146.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 164.0, 165.0, 171.0, 165.0, 166.0, 186.0, 163.0, 163.0], "value": 166.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 76.0, 76.0, 167.0, 76.0, 77.0, 79.0, 74.0, 166.0, 76.0], "value": 96.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 79.0, 137.0, 80.0, 84.0, 79.0, 132.0, 82.0, 79.0, 133.0], "value": 97.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 123.0, 114.0, 120.0, 114.0, 114.0, 114.0, 114.0, 113.0, 117.0], "value": 115.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 149.0, 152.0, 150.0, 148.0, 149.0, 152.0, 148.0, 154.0, 148.0], "value": 150.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 95.0, 104.0, 95.0, 95.0, 107.0, 96.0, 99.0, 94.0, 95.0], "value": 97.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 52.0, 52.0, 60.0, 52.0, 52.0, 54.0, 56.0, 52.0, 53.0], "value": 53.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 46.0, 49.0, 41.0, 39.0, 37.0, 38.0, 37.0, 45.0, 37.0], "value": 40.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 79.0, 75.0, 76.0, 75.0, 86.0, 79.0, 76.0, 76.0, 87.0], "value": 79.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 126.0, 123.0, 121.0, 127.0, 127.0, 129.0, 123.0, 125.0, 163.0], "value": 129.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 172.0, 170.0, 162.0, 203.0, 172.0, 182.0, 168.0, 181.0, 170.0], "value": 175.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 63.0, 65.0, 64.0, 67.0, 67.0, 63.0, 64.0, 66.0, 65.0], "value": 65.2, "unit": "score"}]}]} 16:50:14 INFO - Return code: 0 16:50:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:50:14 INFO - # TBPL SUCCESS # 16:50:14 INFO - Running post-action listener: _package_coverage_data 16:50:14 INFO - Running post-action listener: _resource_record_post_action 16:50:14 INFO - [mozharness: 2017-08-29 23:50:14.823845Z] Finished run-tests step (success) 16:50:14 INFO - Running post-run listener: _resource_record_post_run 16:50:14 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 3932160; Write bytes: 389292032; Read time: 2532; Write time: 216024 16:50:14 INFO - TinderboxPrint: CPU usage
13.3% 16:50:14 INFO - TinderboxPrint: I/O read bytes / time
3,932,160 / 2,532 16:50:14 INFO - TinderboxPrint: I/O write bytes / time
389,292,032 / 216,024 16:50:14 INFO - TinderboxPrint: CPU idle
8,273.4 (86.7%) 16:50:14 INFO - TinderboxPrint: CPU user
1,202.2 (12.6%) 16:50:14 INFO - TinderboxPrint: Swap in / out
0 / 0 16:50:14 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 98975744; Read time: 52; Write time: 65008 16:50:14 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 16:50:14 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 3928064; Write bytes: 290316288; Read time: 2480; Write time: 151016 16:50:15 INFO - Running post-run listener: _upload_blobber_files 16:50:15 INFO - Blob upload gear active. 16:50:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:50:15 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:50:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:50:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:50:15 INFO - (blobuploader) - INFO - Open directory for files ... 16:50:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:50:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:50:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:50:16 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:50:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:50:16 INFO - (blobuploader) - INFO - Done attempting. 16:50:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:50:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:50:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:50:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:50:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:50:18 INFO - (blobuploader) - INFO - Done attempting. 16:50:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:50:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:50:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:50:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:50:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:50:25 INFO - (blobuploader) - INFO - Done attempting. 16:50:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:50:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:50:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:50:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:50:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:50:26 INFO - (blobuploader) - INFO - Done attempting. 16:50:26 INFO - (blobuploader) - INFO - Iteration through files over. 16:50:26 INFO - Return code: 0 16:50:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:50:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:50:26 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9209c4a6392ddedd465d5e565715a0bbb634879761d53aae68d01111bb23b31951ac042c49c62b5d8e8aa3dc15e94235a059121294373ab9b4a6664a2a1dfa03", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4aaa2c1f691b8bf4e53db39fdbbfa16ccf6a7b06fc59e542695ad4c7b112d982fadc20a7bcc882ca21bbd354ae1e7a8ae76f77ee751865f5180bb106fd8ac3c8", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/76267ac183afa42cc3dc8bf84cdb50ad1de49c69af8a0787b47029467e0dcc5344fedd68a6eeb8741bd8ab6874390a75347678e3180cd14eee6f521850162f77", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9c8d048b22d821d245e78126ab2e1fdc98966312148eb106505b6bdeb4fa9e95ce86a0909aa734de08391910394e5ec59706c7e944bf7bb6fc7db18e2c1831a9"} 16:50:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:50:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:50:26 INFO - Contents: 16:50:26 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9209c4a6392ddedd465d5e565715a0bbb634879761d53aae68d01111bb23b31951ac042c49c62b5d8e8aa3dc15e94235a059121294373ab9b4a6664a2a1dfa03", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4aaa2c1f691b8bf4e53db39fdbbfa16ccf6a7b06fc59e542695ad4c7b112d982fadc20a7bcc882ca21bbd354ae1e7a8ae76f77ee751865f5180bb106fd8ac3c8", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/76267ac183afa42cc3dc8bf84cdb50ad1de49c69af8a0787b47029467e0dcc5344fedd68a6eeb8741bd8ab6874390a75347678e3180cd14eee6f521850162f77", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9c8d048b22d821d245e78126ab2e1fdc98966312148eb106505b6bdeb4fa9e95ce86a0909aa734de08391910394e5ec59706c7e944bf7bb6fc7db18e2c1831a9"} 16:50:26 INFO - Running post-run listener: copy_logs_to_upload_dir 16:50:26 INFO - Copying logs to upload dir... 16:50:26 INFO - mkdir: /builds/slave/test/build/upload/logs 16:50:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.623405 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-08-29 16:50:26.056270) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-29 16:50:26.060726) ========= 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=fcadb68e09dcf59683000ff6000001dc-1504042539.837449-895384914 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/9209c4a6392ddedd465d5e565715a0bbb634879761d53aae68d01111bb23b31951ac042c49c62b5d8e8aa3dc15e94235a059121294373ab9b4a6664a2a1dfa03", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4aaa2c1f691b8bf4e53db39fdbbfa16ccf6a7b06fc59e542695ad4c7b112d982fadc20a7bcc882ca21bbd354ae1e7a8ae76f77ee751865f5180bb106fd8ac3c8", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/76267ac183afa42cc3dc8bf84cdb50ad1de49c69af8a0787b47029467e0dcc5344fedd68a6eeb8741bd8ab6874390a75347678e3180cd14eee6f521850162f77", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9c8d048b22d821d245e78126ab2e1fdc98966312148eb106505b6bdeb4fa9e95ce86a0909aa734de08391910394e5ec59706c7e944bf7bb6fc7db18e2c1831a9"} build_url:https://queue.taskcluster.net/v1/task/OLOX1rRMRjiLLTkG5J30Ew/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011227 build_url: 'https://queue.taskcluster.net/v1/task/OLOX1rRMRjiLLTkG5J30Ew/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9209c4a6392ddedd465d5e565715a0bbb634879761d53aae68d01111bb23b31951ac042c49c62b5d8e8aa3dc15e94235a059121294373ab9b4a6664a2a1dfa03", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4aaa2c1f691b8bf4e53db39fdbbfa16ccf6a7b06fc59e542695ad4c7b112d982fadc20a7bcc882ca21bbd354ae1e7a8ae76f77ee751865f5180bb106fd8ac3c8", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/76267ac183afa42cc3dc8bf84cdb50ad1de49c69af8a0787b47029467e0dcc5344fedd68a6eeb8741bd8ab6874390a75347678e3180cd14eee6f521850162f77", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9c8d048b22d821d245e78126ab2e1fdc98966312148eb106505b6bdeb4fa9e95ce86a0909aa734de08391910394e5ec59706c7e944bf7bb6fc7db18e2c1831a9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-29 16:50:26.094598) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-29 16:50:26.094928) ========= 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=fcadb68e09dcf59683000ff6000001dc-1504042539.837449-895384914 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004383 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-29 16:50:26.178239) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-29 16:50:26.178578) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-29 16:50:26.178897) ========= ========= Total master_lag: 0.19 =========