builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-043 starttime: 1506542003.94 results: success (0) revision: b21b199adf72fc9b208073fc887e2e50fa82681a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-27 12:53:23.936180) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-27 12:53:23.936744) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-27 12:53:23.937053) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-27 12:53:23.950673) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 12:53:23.951098) ========= 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=d2a8c569965ab8367867b893000001a1-1506542003.74556-1805683729 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-27 12:53: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% 46.0M=0s 2017-09-27 12:53:24 (46.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.130586 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 12:53:24.095564) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 12:53:24.095905) ========= 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=d2a8c569965ab8367867b893000001a1-1506542003.74556-1805683729 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018933 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 12:53:24.145865) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 12:53:24.146211) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev b21b199adf72fc9b208073fc887e2e50fa82681a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev b21b199adf72fc9b208073fc887e2e50fa82681a --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=d2a8c569965ab8367867b893000001a1-1506542003.74556-1805683729 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-27 12:53:24,247 truncating revision to first 12 chars 2017-09-27 12:53:24,248 Setting DEBUG logging. 2017-09-27 12:53:24,248 attempt 1/10 2017-09-27 12:53:24,248 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/b21b199adf72?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-27 12:53:24,760 unpacking tar archive at: mozilla-beta-b21b199adf72/testing/mozharness/ program finished with exit code 0 elapsedTime=0.785615 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 12:53:24.948586) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-27 12:53:24.948958) ========= script_repo_revision: b21b199adf72fc9b208073fc887e2e50fa82681a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-27 12:53:24.949376) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-27 12:53:24.949686) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-27 12:53:24.963837) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2017-09-27 12:53:24.964408) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO 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', 'Mozilla-Beta-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta-Non-PGO'] 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=d2a8c569965ab8367867b893000001a1-1506542003.74556-1805683729 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:53:25 INFO - MultiFileLogger online at 20170927 12:53:25 in /builds/slave/test 12:53:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO 12:53:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:53:25 INFO - {'append_to_log': False, 12:53:25 INFO - 'base_work_dir': '/builds/slave/test', 12:53:25 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 12:53:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:53:25 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 12:53:25 INFO - 'buildbot_json_path': 'buildprops.json', 12:53:25 INFO - 'code_coverage': False, 12:53:25 INFO - 'config_files': ('talos/linux_config.py',), 12:53:25 INFO - 'default_actions': ('clobber', 12:53:25 INFO - 'read-buildbot-config', 12:53:25 INFO - 'download-and-extract', 12:53:25 INFO - 'populate-webroot', 12:53:25 INFO - 'create-virtualenv', 12:53:25 INFO - 'install', 12:53:25 INFO - 'setup-mitmproxy', 12:53:25 INFO - 'run-tests'), 12:53:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:53:25 INFO - 'disable_ccov_upload': False, 12:53:25 INFO - 'disable_stylo': False, 12:53:25 INFO - 'download_minidump_stackwalk': True, 12:53:25 INFO - 'download_symbols': 'ondemand', 12:53:25 INFO - 'enable_stylo': False, 12:53:25 INFO - 'enable_webrender': False, 12:53:25 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 12:53:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:53:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:53:25 INFO - 'gecko_profile': False, 12:53:25 INFO - 'gecko_profile_interval': 0, 12:53:25 INFO - 'installer_path': 'installer.exe', 12:53:25 INFO - 'log_level': 'info', 12:53:25 INFO - 'log_name': 'talos', 12:53:25 INFO - 'log_to_console': True, 12:53:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:53:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:53:25 INFO - 'opt_config_files': (), 12:53:25 INFO - 'pip_index': False, 12:53:25 INFO - 'suite': 'dromaeojs-e10s', 12:53:25 INFO - 'system_bits': '32', 12:53:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:53:25 INFO - 'title': 'talos-linux64-ix-043', 12:53:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:53:25 INFO - 'use_talos_json': True, 12:53:25 INFO - 'verify': 'False', 12:53:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:53:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:53:25 INFO - 'work_dir': 'build'} 12:53:25 INFO - [mozharness: 2017-09-27 19:53:25.213969Z] Running clobber step. 12:53:25 INFO - Running pre-action listener: _resource_record_pre_action 12:53:25 INFO - Running main action method: clobber 12:53:25 INFO - rmtree: /builds/slave/test/build 12:53:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:53:26 INFO - Running post-action listener: _resource_record_post_action 12:53:26 INFO - [mozharness: 2017-09-27 19:53:26.813492Z] Finished clobber step (success) 12:53:26 INFO - [mozharness: 2017-09-27 19:53:26.813589Z] Running read-buildbot-config step. 12:53:26 INFO - Running pre-action listener: _resource_record_pre_action 12:53:26 INFO - Running main action method: read_buildbot_config 12:53:26 INFO - Using buildbot properties: 12:53:26 INFO - { 12:53:26 INFO - "project": "", 12:53:26 INFO - "product": "firefox", 12:53:26 INFO - "who": "ryanvm@gmail.com", 12:53:26 INFO - "installer_path": "public/build/target.tar.bz2", 12:53:26 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 12:53:26 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 12:53:26 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs-e10s", 12:53:26 INFO - "stage_platform": "linux64", 12:53:26 INFO - "basedir": "/builds/slave/test", 12:53:26 INFO - "buildnumber": 121, 12:53:26 INFO - "platform": "ubuntu64_hw", 12:53:26 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 12:53:26 INFO - "slavebuilddir": "test", 12:53:26 INFO - "taskId": "czr6fa7fSQqx0QUyWN6wFQ", 12:53:26 INFO - "branch": "mozilla-beta", 12:53:26 INFO - "script_repo_revision": "production", 12:53:26 INFO - "revision": "b21b199adf72fc9b208073fc887e2e50fa82681a", 12:53:26 INFO - "slavename": "talos-linux64-ix-043", 12:53:26 INFO - "repo_path": "releases/mozilla-beta" 12:53:26 INFO - } 12:53:26 INFO - Finding installer, test and symbols from parent task. 12:53:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/czr6fa7fSQqx0QUyWN6wFQ'}, attempt #1 12:53:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/czr6fa7fSQqx0QUyWN6wFQ'}, attempt #1 12:53:27 INFO - Task dependencies: ADu_DyoQRUasrawy0ZNw_A 12:53:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ADu_DyoQRUasrawy0ZNw_A'}, attempt #1 12:53:28 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/ADu_DyoQRUasrawy0ZNw_A/artifacts/public/build/target.tar.bz2 12:53:28 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/ADu_DyoQRUasrawy0ZNw_A/artifacts/public/build/target.test_packages.json 12:53:28 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/ADu_DyoQRUasrawy0ZNw_A/artifacts/public/build/target.crashreporter-symbols.zip 12:53:28 INFO - Running post-action listener: _resource_record_post_action 12:53:28 INFO - [mozharness: 2017-09-27 19:53:28.165269Z] Finished read-buildbot-config step (success) 12:53:28 INFO - [mozharness: 2017-09-27 19:53:28.165486Z] Running download-and-extract step. 12:53:28 INFO - Running pre-action listener: _resource_record_pre_action 12:53:28 INFO - Running main action method: download_and_extract 12:53:28 INFO - mkdir: /builds/slave/test/build/tests 12:53:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:53:28 INFO - trying https://queue.taskcluster.net/v1/task/ADu_DyoQRUasrawy0ZNw_A/artifacts/public/build/target.test_packages.json 12:53:28 INFO - Downloading https://queue.taskcluster.net/v1/task/ADu_DyoQRUasrawy0ZNw_A/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 12:53:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ADu_DyoQRUasrawy0ZNw_A/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 12:53:28 INFO - Downloaded 989 bytes. 12:53:28 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 12:53:28 INFO - Using the following test package requirements: 12:53:28 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 12:53:28 INFO - u'common': [u'target.common.tests.zip'], 12:53:28 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 12:53:28 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 12:53:28 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 12:53:28 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 12:53:28 INFO - u'mozbase': [u'target.common.tests.zip'], 12:53:28 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 12:53:28 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 12:53:28 INFO - u'web-platform': [u'target.common.tests.zip', 12:53:28 INFO - u'target.web-platform.tests.tar.gz'], 12:53:28 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 12:53:28 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 12:53:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ADu_DyoQRUasrawy0ZNw_A/artifacts/public/build/target.common.tests.zip 12:53:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ADu_DyoQRUasrawy0ZNw_A/artifacts/public/build/target.common.tests.zip'}, attempt #1 12:53:28 INFO - Fetch https://queue.taskcluster.net/v1/task/ADu_DyoQRUasrawy0ZNw_A/artifacts/public/build/target.common.tests.zip into memory 12:53:29 INFO - Content-Length response header: 55180186 12:53:29 INFO - Bytes received: 55180186 12:53:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ADu_DyoQRUasrawy0ZNw_A/artifacts/public/build/target.talos.tests.zip 12:53:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ADu_DyoQRUasrawy0ZNw_A/artifacts/public/build/target.talos.tests.zip'}, attempt #1 12:53:40 INFO - Fetch https://queue.taskcluster.net/v1/task/ADu_DyoQRUasrawy0ZNw_A/artifacts/public/build/target.talos.tests.zip into memory 12:53:41 INFO - Content-Length response header: 14509184 12:53:41 INFO - Bytes received: 14509184 12:53:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:53:41 INFO - trying https://queue.taskcluster.net/v1/task/ADu_DyoQRUasrawy0ZNw_A/artifacts/public/build/target.tar.bz2 12:53:41 INFO - Downloading https://queue.taskcluster.net/v1/task/ADu_DyoQRUasrawy0ZNw_A/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 12:53:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ADu_DyoQRUasrawy0ZNw_A/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 12:53:42 INFO - Downloaded 53450893 bytes. 12:53:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ADu_DyoQRUasrawy0ZNw_A/artifacts/public/build/target.tar.bz2 12:53:43 INFO - mkdir: /builds/slave/test/properties 12:53:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:53:43 INFO - Writing to file /builds/slave/test/properties/build_url 12:53:43 INFO - Contents: 12:53:43 INFO - build_url:https://queue.taskcluster.net/v1/task/ADu_DyoQRUasrawy0ZNw_A/artifacts/public/build/target.tar.bz2 12:53:43 INFO - Running post-action listener: _resource_record_post_action 12:53:43 INFO - Running post-action listener: find_tests_for_verification 12:53:43 INFO - Running post-action listener: set_extra_try_arguments 12:53:43 INFO - [mozharness: 2017-09-27 19:53:43.010531Z] Finished download-and-extract step (success) 12:53:43 INFO - [mozharness: 2017-09-27 19:53:43.010630Z] Running populate-webroot step. 12:53:43 INFO - Running pre-action listener: _resource_record_pre_action 12:53:43 INFO - Running main action method: populate_webroot 12:53:43 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:53:43 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:53:43 INFO - 'tests': ['tresize', 12:53:43 INFO - 'tcanvasmark']}, 12:53:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:53:43 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:53:43 INFO - 'tests': ['dromaeo_css', 12:53:43 INFO - 'kraken']}, 12:53:43 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 12:53:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:53:43 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 12:53:43 INFO - 'talos_options': ['--disable-stylo'], 12:53:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:53:43 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 12:53:43 INFO - 'tests': ['damp', 'tps']}, 12:53:43 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 12:53:43 INFO - 'talos_options': ['--disable-stylo'], 12:53:43 INFO - 'tests': ['damp', 'tps']}, 12:53:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:53:43 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:53:43 INFO - 'tests': ['dromaeo_dom']}, 12:53:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 12:53:43 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:53:43 INFO - 'tests': ['basic_compositor_video', 12:53:43 INFO - 'glvideo']}, 12:53:43 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 12:53:43 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 12:53:43 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 12:53:43 INFO - 'talos_options': ['--disable-stylo'], 12:53:43 INFO - 'tests': ['ts_paint_webext', 12:53:43 INFO - 'tp5o_webext']}, 12:53:43 INFO - 'other-e10s': {'tests': ['a11yr', 12:53:43 INFO - 'ts_paint', 12:53:43 INFO - 'tpaint', 12:53:43 INFO - 'sessionrestore', 12:53:43 INFO - 'sessionrestore_many_windows', 12:53:43 INFO - 'sessionrestore_no_auto_restore', 12:53:43 INFO - 'tabpaint']}, 12:53:43 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:53:43 INFO - 'tests': ['a11yr', 12:53:43 INFO - 'ts_paint', 12:53:43 INFO - 'tpaint', 12:53:43 INFO - 'sessionrestore', 12:53:43 INFO - 'sessionrestore_many_windows', 12:53:43 INFO - 'sessionrestore_no_auto_restore', 12:53:43 INFO - 'tabpaint']}, 12:53:43 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 12:53:43 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 12:53:43 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:53:43 INFO - 'tests': ['perf_reftest_singletons']}, 12:53:43 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:53:43 INFO - 'tests': ['bloom_basic']}, 12:53:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:53:43 INFO - 'tsvgr_opacity', 12:53:43 INFO - 'tart', 12:53:43 INFO - 'tscrollx', 12:53:43 INFO - 'tsvg_static']}, 12:53:43 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:53:43 INFO - 'tests': ['tsvgx', 12:53:43 INFO - 'tsvgr_opacity', 12:53:43 INFO - 'tart', 12:53:43 INFO - 'tscrollx', 12:53:43 INFO - 'tsvg_static']}, 12:53:43 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 12:53:43 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 12:53:43 INFO - 'talos_options': ['--disable-stylo'], 12:53:43 INFO - 'tests': ['tp5o']}, 12:53:43 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 12:53:43 INFO - 'talos_options': ['--mitmproxy', 12:53:43 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 12:53:43 INFO - '--firstNonBlankPaint'], 12:53:43 INFO - 'tests': ['tp6_google', 12:53:43 INFO - 'tp6_youtube', 12:53:43 INFO - 'tp6_amazon', 12:53:43 INFO - 'tp6_facebook']}, 12:53:43 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 12:53:43 INFO - 'talos_options': ['--disable-stylo', 12:53:43 INFO - '--mitmproxy', 12:53:43 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 12:53:43 INFO - '--firstNonBlankPaint'], 12:53:43 INFO - 'tests': ['tp6_google', 12:53:43 INFO - 'tp6_youtube', 12:53:43 INFO - 'tp6_amazon', 12:53:43 INFO - 'tp6_facebook']}, 12:53:43 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 12:53:43 INFO - 'talos_options': ['--stylo-threads=1', 12:53:43 INFO - '--mitmproxy', 12:53:43 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 12:53:43 INFO - '--firstNonBlankPaint'], 12:53:43 INFO - 'tests': ['tp6_google', 12:53:43 INFO - 'tp6_youtube', 12:53:43 INFO - 'tp6_amazon', 12:53:43 INFO - 'tp6_facebook']}, 12:53:43 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 12:53:43 INFO - 'talos_options': ['--xperf_path', 12:53:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:53:43 INFO - 'tests': ['tp5n']}, 12:53:43 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 12:53:43 INFO - 'talos_options': ['--disable-stylo', 12:53:43 INFO - '--xperf_path', 12:53:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:53:43 INFO - 'tests': ['tp5n']}}} 12:53:43 INFO - Running post-action listener: _resource_record_post_action 12:53:43 INFO - [mozharness: 2017-09-27 19:53:43.033071Z] Finished populate-webroot step (success) 12:53:43 INFO - [mozharness: 2017-09-27 19:53:43.033160Z] Running create-virtualenv step. 12:53:43 INFO - Running pre-action listener: _resource_record_pre_action 12:53:43 INFO - Running main action method: create_virtualenv 12:53:43 INFO - Creating virtualenv /builds/slave/test/build/venv 12:53:43 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 12:53:43 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 12:53:43 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 12:53:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:53:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:53:43 INFO - Installing distribute.............................................................................................................................................................................................done. 12:53:43 INFO - Installing pip...............done. 12:53:43 INFO - Return code: 0 12:53:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:53:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:53:44 INFO - Reading from file tmpfile_stdout 12:53:44 INFO - Output received: 12:53:44 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 12:53:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:53:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:53:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:53:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:53:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:53:44 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 0xc441f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfafa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb3090>, '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 0xfb3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfadf90>, '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': 'd2a8c569965ab8367867b893000001a1-1506542003.74556-1805683729', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:53:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:53:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:53:44 INFO - Using env: {'DISPLAY': ':0', 12:53:44 INFO - 'HOME': '/home/cltbld', 12:53:44 INFO - 'LANG': 'en_US.UTF-8', 12:53:44 INFO - 'LANGUAGE': 'en_US:en', 12:53:44 INFO - 'LOGNAME': 'cltbld', 12:53:44 INFO - 'MAIL': '/var/mail/cltbld', 12:53:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:53:44 INFO - 'MOZ_NO_REMOTE': '1', 12:53:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:53:44 INFO - 'NO_EM_RESTART': '1', 12:53:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:53:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:53:44 INFO - 'PWD': '/builds/slave/test', 12:53:44 INFO - 'SHELL': '/bin/bash', 12:53:44 INFO - 'SHLVL': '1', 12:53:44 INFO - 'TERM': 'linux', 12:53:44 INFO - 'TMOUT': '86400', 12:53:44 INFO - 'USER': 'cltbld', 12:53:44 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1506542003.74556-1805683729', 12:53:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:53:44 INFO - '_': '/tools/buildbot/bin/python'} 12:53:45 INFO - Ignoring indexes: http://pypi.python.org/simple/ 12:53:45 INFO - Downloading/unpacking pip>=1.5 12:53:45 INFO - Running setup.py egg_info for package pip 12:53:45 INFO - warning: no files found matching 'pip/cacert.pem' 12:53:45 INFO - warning: no files found matching '*.html' under directory 'docs' 12:53:45 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 12:53:45 INFO - no previously-included directories found matching 'docs/_build/_sources' 12:53:45 INFO - Installing collected packages: pip 12:53:45 INFO - Found existing installation: pip 1.1 12:53:45 INFO - Uninstalling pip: 12:53:45 INFO - Successfully uninstalled pip 12:53:45 INFO - Running setup.py install for pip 12:53:45 INFO - warning: no files found matching 'pip/cacert.pem' 12:53:45 INFO - warning: no files found matching '*.html' under directory 'docs' 12:53:45 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 12:53:45 INFO - no previously-included directories found matching 'docs/_build/_sources' 12:53:45 INFO - Installing pip script to /builds/slave/test/build/venv/bin 12:53:45 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 12:53:45 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 12:53:45 INFO - Successfully installed pip 12:53:45 INFO - Cleaning up... 12:53:45 INFO - Return code: 0 12:53:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:53:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:53:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:53:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:53:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:53:45 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 0xc441f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfafa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb3090>, '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 0xfb3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfadf90>, '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': 'd2a8c569965ab8367867b893000001a1-1506542003.74556-1805683729', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:53:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 12:53:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 12:53:45 INFO - Using env: {'DISPLAY': ':0', 12:53:45 INFO - 'HOME': '/home/cltbld', 12:53:45 INFO - 'LANG': 'en_US.UTF-8', 12:53:45 INFO - 'LANGUAGE': 'en_US:en', 12:53:45 INFO - 'LOGNAME': 'cltbld', 12:53:45 INFO - 'MAIL': '/var/mail/cltbld', 12:53:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:53:45 INFO - 'MOZ_NO_REMOTE': '1', 12:53:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:53:45 INFO - 'NO_EM_RESTART': '1', 12:53:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:53:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:53:45 INFO - 'PWD': '/builds/slave/test', 12:53:45 INFO - 'SHELL': '/bin/bash', 12:53:45 INFO - 'SHLVL': '1', 12:53:45 INFO - 'TERM': 'linux', 12:53:45 INFO - 'TMOUT': '86400', 12:53:45 INFO - 'USER': 'cltbld', 12:53:45 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1506542003.74556-1805683729', 12:53:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:53:45 INFO - '_': '/tools/buildbot/bin/python'} 12:53:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:53:45 INFO - Downloading/unpacking psutil>=3.1.1 12:53:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:53:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:53:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:53:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:53:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:53:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:53:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:53:46 INFO - Installing collected packages: psutil 12:53:46 INFO - Running setup.py install for psutil 12:53:46 INFO - building 'psutil._psutil_linux' extension 12:53:46 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 12:53:46 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 12:53:46 INFO - building 'psutil._psutil_posix' extension 12:53:46 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 12:53:47 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 12:53:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:53:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:53:47 INFO - Successfully installed psutil 12:53:47 INFO - Cleaning up... 12:53:47 INFO - Return code: 0 12:53:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:53:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:53:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:53:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:53:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:53:47 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 0xc441f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfafa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb3090>, '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 0xfb3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfadf90>, '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': 'd2a8c569965ab8367867b893000001a1-1506542003.74556-1805683729', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:53:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 12:53:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 12:53:47 INFO - Using env: {'DISPLAY': ':0', 12:53:47 INFO - 'HOME': '/home/cltbld', 12:53:47 INFO - 'LANG': 'en_US.UTF-8', 12:53:47 INFO - 'LANGUAGE': 'en_US:en', 12:53:47 INFO - 'LOGNAME': 'cltbld', 12:53:47 INFO - 'MAIL': '/var/mail/cltbld', 12:53:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:53:47 INFO - 'MOZ_NO_REMOTE': '1', 12:53:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:53:47 INFO - 'NO_EM_RESTART': '1', 12:53:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:53:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:53:47 INFO - 'PWD': '/builds/slave/test', 12:53:47 INFO - 'SHELL': '/bin/bash', 12:53:47 INFO - 'SHLVL': '1', 12:53:47 INFO - 'TERM': 'linux', 12:53:47 INFO - 'TMOUT': '86400', 12:53:47 INFO - 'USER': 'cltbld', 12:53:47 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1506542003.74556-1805683729', 12:53:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:53:47 INFO - '_': '/tools/buildbot/bin/python'} 12:53:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:53:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:53:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:53:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:53:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:53:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:53:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:53:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:53:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:53:48 INFO - Installing collected packages: mozsystemmonitor 12:53:48 INFO - Running setup.py install for mozsystemmonitor 12:53:48 INFO - Successfully installed mozsystemmonitor 12:53:48 INFO - Cleaning up... 12:53:49 INFO - Return code: 0 12:53:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:53:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:53:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:53:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:53:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:53:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xc441f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfafa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb3090>, '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 0xfb3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfadf90>, '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': 'd2a8c569965ab8367867b893000001a1-1506542003.74556-1805683729', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:53:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:53:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 12:53:49 INFO - Using env: {'DISPLAY': ':0', 12:53:49 INFO - 'HOME': '/home/cltbld', 12:53:49 INFO - 'LANG': 'en_US.UTF-8', 12:53:49 INFO - 'LANGUAGE': 'en_US:en', 12:53:49 INFO - 'LOGNAME': 'cltbld', 12:53:49 INFO - 'MAIL': '/var/mail/cltbld', 12:53:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:53:49 INFO - 'MOZ_NO_REMOTE': '1', 12:53:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:53:49 INFO - 'NO_EM_RESTART': '1', 12:53:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:53:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:53:49 INFO - 'PWD': '/builds/slave/test', 12:53:49 INFO - 'SHELL': '/bin/bash', 12:53:49 INFO - 'SHLVL': '1', 12:53:49 INFO - 'TERM': 'linux', 12:53:49 INFO - 'TMOUT': '86400', 12:53:49 INFO - 'USER': 'cltbld', 12:53:49 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1506542003.74556-1805683729', 12:53:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:53:49 INFO - '_': '/tools/buildbot/bin/python'} 12:53:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:53:49 INFO - Downloading/unpacking jsonschema==2.5.1 12:53:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:53:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:53:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:53:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:53:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:53:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:53:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:53:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:53:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:53:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:53:50 INFO - Downloading functools32-3.2.3-2.tar.gz 12:53:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:53:50 INFO - warning: no files found matching '*.txt' 12:53:50 INFO - no previously-included directories found matching 'build' 12:53:50 INFO - no previously-included directories found matching 'dist' 12:53:50 INFO - no previously-included directories found matching '.git*' 12:53:50 INFO - Installing collected packages: jsonschema, functools32 12:53:51 INFO - Running setup.py install for functools32 12:53:51 INFO - warning: no files found matching '*.txt' 12:53:51 INFO - no previously-included directories found matching 'build' 12:53:51 INFO - no previously-included directories found matching 'dist' 12:53:51 INFO - no previously-included directories found matching '.git*' 12:53:51 INFO - Successfully installed jsonschema functools32 12:53:51 INFO - Cleaning up... 12:53:51 INFO - Return code: 0 12:53:51 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:53:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:53:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:53:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:53:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:53:51 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 0xc441f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfafa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb3090>, '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 0xfb3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfadf90>, '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': 'd2a8c569965ab8367867b893000001a1-1506542003.74556-1805683729', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:53:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 12:53:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 12:53:51 INFO - Using env: {'DISPLAY': ':0', 12:53:51 INFO - 'HOME': '/home/cltbld', 12:53:51 INFO - 'LANG': 'en_US.UTF-8', 12:53:51 INFO - 'LANGUAGE': 'en_US:en', 12:53:51 INFO - 'LOGNAME': 'cltbld', 12:53:51 INFO - 'MAIL': '/var/mail/cltbld', 12:53:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:53:51 INFO - 'MOZ_NO_REMOTE': '1', 12:53:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:53:51 INFO - 'NO_EM_RESTART': '1', 12:53:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:53:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:53:51 INFO - 'PWD': '/builds/slave/test', 12:53:51 INFO - 'SHELL': '/bin/bash', 12:53:51 INFO - 'SHLVL': '1', 12:53:51 INFO - 'TERM': 'linux', 12:53:51 INFO - 'TMOUT': '86400', 12:53:51 INFO - 'USER': 'cltbld', 12:53:51 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1506542003.74556-1805683729', 12:53:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:53:51 INFO - '_': '/tools/buildbot/bin/python'} 12:53:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:53:51 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:53:51 INFO - Cleaning up... 12:53:51 INFO - Return code: 0 12:53:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:53:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:53:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:53:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:53:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:53:51 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 0xc441f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfafa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb3090>, '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 0xfb3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfadf90>, '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': 'd2a8c569965ab8367867b893000001a1-1506542003.74556-1805683729', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:53:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:53:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:53:51 INFO - Using env: {'DISPLAY': ':0', 12:53:51 INFO - 'HOME': '/home/cltbld', 12:53:51 INFO - 'LANG': 'en_US.UTF-8', 12:53:51 INFO - 'LANGUAGE': 'en_US:en', 12:53:51 INFO - 'LOGNAME': 'cltbld', 12:53:51 INFO - 'MAIL': '/var/mail/cltbld', 12:53:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:53:51 INFO - 'MOZ_NO_REMOTE': '1', 12:53:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:53:51 INFO - 'NO_EM_RESTART': '1', 12:53:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:53:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:53:51 INFO - 'PWD': '/builds/slave/test', 12:53:51 INFO - 'SHELL': '/bin/bash', 12:53:51 INFO - 'SHLVL': '1', 12:53:51 INFO - 'TERM': 'linux', 12:53:51 INFO - 'TMOUT': '86400', 12:53:51 INFO - 'USER': 'cltbld', 12:53:51 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1506542003.74556-1805683729', 12:53:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:53:51 INFO - '_': '/tools/buildbot/bin/python'} 12:53:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:53:51 INFO - Downloading/unpacking blobuploader==1.2.4 12:53:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:53:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:53:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:53:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:53:52 INFO - Downloading blobuploader-1.2.4.tar.gz 12:53:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:53:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:53:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:53:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:53:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:53:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:53:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:53:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:53:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:53:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:53:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:53:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:53:53 INFO - Downloading docopt-0.6.1.tar.gz 12:53:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:53:53 INFO - Installing collected packages: blobuploader, requests, docopt 12:53:53 INFO - Running setup.py install for blobuploader 12:53:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:53:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:53:53 INFO - Running setup.py install for requests 12:53:53 INFO - Running setup.py install for docopt 12:53:53 INFO - Successfully installed blobuploader requests docopt 12:53:53 INFO - Cleaning up... 12:53:53 INFO - Return code: 0 12:53:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:53:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:53:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:53:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:53:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:53:53 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 0xc441f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfafa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb3090>, '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 0xfb3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfadf90>, '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': 'd2a8c569965ab8367867b893000001a1-1506542003.74556-1805683729', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:53:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:53:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:53:53 INFO - Using env: {'DISPLAY': ':0', 12:53:53 INFO - 'HOME': '/home/cltbld', 12:53:53 INFO - 'LANG': 'en_US.UTF-8', 12:53:53 INFO - 'LANGUAGE': 'en_US:en', 12:53:53 INFO - 'LOGNAME': 'cltbld', 12:53:53 INFO - 'MAIL': '/var/mail/cltbld', 12:53:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:53:53 INFO - 'MOZ_NO_REMOTE': '1', 12:53:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:53:53 INFO - 'NO_EM_RESTART': '1', 12:53:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:53:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:53:53 INFO - 'PWD': '/builds/slave/test', 12:53:53 INFO - 'SHELL': '/bin/bash', 12:53:53 INFO - 'SHLVL': '1', 12:53:53 INFO - 'TERM': 'linux', 12:53:53 INFO - 'TMOUT': '86400', 12:53:53 INFO - 'USER': 'cltbld', 12:53:53 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1506542003.74556-1805683729', 12:53:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:53:53 INFO - '_': '/tools/buildbot/bin/python'} 12:53:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:53:54 INFO - Running setup.py (path:/tmp/pip-q5uJO7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:53:54 INFO - Running setup.py (path:/tmp/pip-g_IcLA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:53:54 INFO - Running setup.py (path:/tmp/pip-BphXrD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:53:54 INFO - Running setup.py (path:/tmp/pip-Z8AhfL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:53:54 INFO - Running setup.py (path:/tmp/pip-iUOAYK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:53:54 INFO - Running setup.py (path:/tmp/pip-PdaGM7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:53:54 INFO - Running setup.py (path:/tmp/pip-FVmjHq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:53:54 INFO - Running setup.py (path:/tmp/pip-6p1gp5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:53:54 INFO - Running setup.py (path:/tmp/pip-f3KBra-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:53:54 INFO - Running setup.py (path:/tmp/pip-AsZDKv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:53:54 INFO - Running setup.py (path:/tmp/pip-7G84zi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:53:54 INFO - Running setup.py (path:/tmp/pip-a0mx49-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:53:55 INFO - Running setup.py (path:/tmp/pip-XiGXbE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:53:55 INFO - Running setup.py (path:/tmp/pip-kL5u1K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:53:55 INFO - Running setup.py (path:/tmp/pip-psqxYp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:53:55 INFO - Running setup.py (path:/tmp/pip-PaywKa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:53:55 INFO - Running setup.py (path:/tmp/pip-rijjaz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:53:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:53:55 INFO - Running setup.py install for manifestparser 12:53:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:53:55 INFO - Running setup.py install for mozcrash 12:53:55 INFO - Running setup.py install for mozdebug 12:53:55 INFO - Running setup.py install for mozdevice 12:53:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:53:55 INFO - Running setup.py install for mozfile 12:53:55 INFO - Running setup.py install for mozhttpd 12:53:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:53:55 INFO - Running setup.py install for mozinfo 12:53:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:53:56 INFO - Running setup.py install for mozInstall 12:53:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:53:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:53:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:53:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:53:56 INFO - Running setup.py install for mozleak 12:53:56 INFO - Running setup.py install for mozlog 12:53:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:53:56 INFO - Running setup.py install for moznetwork 12:53:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:53:56 INFO - Running setup.py install for mozprocess 12:53:56 INFO - Running setup.py install for mozprofile 12:53:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:53:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:53:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:53:56 INFO - Running setup.py install for mozrunner 12:53:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:53:56 INFO - Running setup.py install for mozscreenshot 12:53:56 INFO - Running setup.py install for moztest 12:53:57 INFO - Running setup.py install for mozversion 12:53:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:53:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:53:57 INFO - Cleaning up... 12:53:57 INFO - Return code: 0 12:53:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:53: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')]} 12:53:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:53: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')]} 12:53:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:53:57 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 0xc441f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfafa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb3090>, '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 0xfb3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfadf90>, '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': 'd2a8c569965ab8367867b893000001a1-1506542003.74556-1805683729', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:53:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:53:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:53:57 INFO - Using env: {'DISPLAY': ':0', 12:53:57 INFO - 'HOME': '/home/cltbld', 12:53:57 INFO - 'LANG': 'en_US.UTF-8', 12:53:57 INFO - 'LANGUAGE': 'en_US:en', 12:53:57 INFO - 'LOGNAME': 'cltbld', 12:53:57 INFO - 'MAIL': '/var/mail/cltbld', 12:53:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:53:57 INFO - 'MOZ_NO_REMOTE': '1', 12:53:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:53:57 INFO - 'NO_EM_RESTART': '1', 12:53:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:53:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:53:57 INFO - 'PWD': '/builds/slave/test', 12:53:57 INFO - 'SHELL': '/bin/bash', 12:53:57 INFO - 'SHLVL': '1', 12:53:57 INFO - 'TERM': 'linux', 12:53:57 INFO - 'TMOUT': '86400', 12:53:57 INFO - 'USER': 'cltbld', 12:53:57 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1506542003.74556-1805683729', 12:53:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:53:57 INFO - '_': '/tools/buildbot/bin/python'} 12:53:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:53:57 INFO - Running setup.py (path:/tmp/pip-sbJ8yi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:53:57 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 12:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:53:57 INFO - Running setup.py (path:/tmp/pip-ZUJw5R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:53:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:53:57 INFO - Running setup.py (path:/tmp/pip-Of5xO8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:53:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:53:57 INFO - Running setup.py (path:/tmp/pip-pRJ1yg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:53:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:53:57 INFO - Running setup.py (path:/tmp/pip-7IBQbj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:53:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 12:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:53:57 INFO - Running setup.py (path:/tmp/pip-0wiRap-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:53:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 12:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:53:57 INFO - Running setup.py (path:/tmp/pip-78ywqg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:53:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 12:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:53:57 INFO - Running setup.py (path:/tmp/pip-gyXJT1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:53:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 12:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:53:57 INFO - Running setup.py (path:/tmp/pip-tCDN1A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:53:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 12:53:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:53:58 INFO - Running setup.py (path:/tmp/pip-j2a_4M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:53:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:53:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:53:58 INFO - Running setup.py (path:/tmp/pip-LCR1Q_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:53:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 12:53:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:53:58 INFO - Running setup.py (path:/tmp/pip-L8nihd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:53:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 12:53:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:53:58 INFO - Running setup.py (path:/tmp/pip-aD25Ix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:53:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 12:53:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:53:58 INFO - Running setup.py (path:/tmp/pip-vUol2c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:53:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 12:53:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:53:58 INFO - Running setup.py (path:/tmp/pip-Mxr68U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:53:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 12:53:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:53:58 INFO - Running setup.py (path:/tmp/pip-2HIsSx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:53:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 12:53:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:53:58 INFO - Running setup.py (path:/tmp/pip-mveiI0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:53:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 12:53:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:53:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:53:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:53:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:53:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:53:58 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 12:53:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:53:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:53:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:53:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:53:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:53:59 INFO - Downloading blessings-1.6.tar.gz 12:53:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:53:59 INFO - Installing collected packages: blessings 12:53:59 INFO - Running setup.py install for blessings 12:53:59 INFO - Successfully installed blessings 12:53:59 INFO - Cleaning up... 12:53:59 INFO - Return code: 0 12:53:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:53:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:53:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:54:00 INFO - Reading from file tmpfile_stdout 12:54:00 INFO - Current package versions: 12:54:00 INFO - argparse == 1.2.1 12:54:00 INFO - blessings == 1.6 12:54:00 INFO - blobuploader == 1.2.4 12:54:00 INFO - docopt == 0.6.1 12:54:00 INFO - functools32 == 3.2.3-2 12:54:00 INFO - jsonschema == 2.5.1 12:54:00 INFO - manifestparser == 1.1 12:54:00 INFO - mozInstall == 1.13 12:54:00 INFO - mozcrash == 1.0 12:54:00 INFO - mozdebug == 0.1 12:54:00 INFO - mozdevice == 0.51 12:54:00 INFO - mozfile == 1.2 12:54:00 INFO - mozhttpd == 0.7 12:54:00 INFO - mozinfo == 0.10 12:54:00 INFO - mozleak == 0.1 12:54:00 INFO - mozlog == 3.5 12:54:00 INFO - moznetwork == 0.27 12:54:00 INFO - mozprocess == 0.25 12:54:00 INFO - mozprofile == 0.28 12:54:00 INFO - mozrunner == 6.13 12:54:00 INFO - mozscreenshot == 0.1 12:54:00 INFO - mozsystemmonitor == 0.3 12:54:00 INFO - moztest == 0.8 12:54:00 INFO - mozversion == 1.4 12:54:00 INFO - psutil == 3.1.1 12:54:00 INFO - requests == 1.2.3 12:54:00 INFO - wsgiref == 0.1.2 12:54:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:54: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')]} 12:54:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54: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')]} 12:54:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:00 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 0xc441f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfafa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb3090>, '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 0xfb3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfadf90>, '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': 'd2a8c569965ab8367867b893000001a1-1506542003.74556-1805683729', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:54:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 12:54:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:54:00 INFO - Using env: {'DISPLAY': ':0', 12:54:00 INFO - 'HOME': '/home/cltbld', 12:54:00 INFO - 'LANG': 'en_US.UTF-8', 12:54:00 INFO - 'LANGUAGE': 'en_US:en', 12:54:00 INFO - 'LOGNAME': 'cltbld', 12:54:00 INFO - 'MAIL': '/var/mail/cltbld', 12:54:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:00 INFO - 'MOZ_NO_REMOTE': '1', 12:54:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:00 INFO - 'NO_EM_RESTART': '1', 12:54:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:00 INFO - 'PWD': '/builds/slave/test', 12:54:00 INFO - 'SHELL': '/bin/bash', 12:54:00 INFO - 'SHLVL': '1', 12:54:00 INFO - 'TERM': 'linux', 12:54:00 INFO - 'TMOUT': '86400', 12:54:00 INFO - 'USER': 'cltbld', 12:54:00 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1506542003.74556-1805683729', 12:54:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:00 INFO - '_': '/tools/buildbot/bin/python'} 12:54:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:54:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 12:54:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 12:54:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:54:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 12:54:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 12:54:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 12:54:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 12:54:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 12:54:00 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 12:54: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 12:54: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 12:54: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 12:54: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 12:54:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 12:54:01 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:54:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:54:01 INFO - Installing collected packages: simplejson 12:54:01 INFO - Running setup.py install for simplejson 12:54:01 INFO - building 'simplejson._speedups' extension 12:54:01 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 12:54:02 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 12:54:02 INFO - Successfully installed simplejson 12:54:02 INFO - Cleaning up... 12:54:02 INFO - Return code: 0 12:54:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:54: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')]} 12:54:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54: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')]} 12:54:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xc441f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfafa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb3090>, '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 0xfb3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfadf90>, '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': 'd2a8c569965ab8367867b893000001a1-1506542003.74556-1805683729', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:54: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', 'jsonschema'] in /builds/slave/test/build 12:54: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 jsonschema 12:54:02 INFO - Using env: {'DISPLAY': ':0', 12:54:02 INFO - 'HOME': '/home/cltbld', 12:54:02 INFO - 'LANG': 'en_US.UTF-8', 12:54:02 INFO - 'LANGUAGE': 'en_US:en', 12:54:02 INFO - 'LOGNAME': 'cltbld', 12:54:02 INFO - 'MAIL': '/var/mail/cltbld', 12:54:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:02 INFO - 'MOZ_NO_REMOTE': '1', 12:54:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:02 INFO - 'NO_EM_RESTART': '1', 12:54:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:02 INFO - 'PWD': '/builds/slave/test', 12:54:02 INFO - 'SHELL': '/bin/bash', 12:54:02 INFO - 'SHLVL': '1', 12:54:02 INFO - 'TERM': 'linux', 12:54:02 INFO - 'TMOUT': '86400', 12:54:02 INFO - 'USER': 'cltbld', 12:54:02 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1506542003.74556-1805683729', 12:54:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:02 INFO - '_': '/tools/buildbot/bin/python'} 12:54:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:54:02 INFO - Cleaning up... 12:54:02 INFO - Return code: 0 12:54:02 INFO - Running post-action listener: _resource_record_post_action 12:54:02 INFO - Running post-action listener: _start_resource_monitoring 12:54:02 INFO - Starting resource monitoring. 12:54:02 INFO - [mozharness: 2017-09-27 19:54:02.892476Z] Finished create-virtualenv step (success) 12:54:02 INFO - [mozharness: 2017-09-27 19:54:02.892984Z] Running install step. 12:54:02 INFO - Running pre-action listener: _resource_record_pre_action 12:54:02 INFO - Running main action method: install 12:54:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:54:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:54:03 INFO - Reading from file tmpfile_stdout 12:54:03 INFO - Detecting whether we're running mozinstall >=1.0... 12:54:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:54:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:54:03 INFO - Reading from file tmpfile_stdout 12:54:03 INFO - Output received: 12:54:03 INFO - Usage: mozinstall [options] installer 12:54:03 INFO - Options: 12:54:03 INFO - -h, --help show this help message and exit 12:54:03 INFO - -d DEST, --destination=DEST 12:54:03 INFO - Directory to install application into. [default: 12:54:03 INFO - "/builds/slave/test"] 12:54:03 INFO - --app=APP Application being installed. [default: firefox] 12:54:03 INFO - mkdir: /builds/slave/test/build/application 12:54:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 12:54:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 12:54:17 INFO - Reading from file tmpfile_stdout 12:54:17 INFO - Output received: 12:54:17 INFO - /builds/slave/test/build/application/firefox/firefox 12:54:17 INFO - Running post-action listener: _resource_record_post_action 12:54:17 INFO - [mozharness: 2017-09-27 19:54:17.850258Z] Finished install step (success) 12:54:17 INFO - [mozharness: 2017-09-27 19:54:17.850507Z] Running setup-mitmproxy step. 12:54:17 INFO - Running pre-action listener: _resource_record_pre_action 12:54:17 INFO - Running main action method: setup_mitmproxy 12:54:17 INFO - Skipping: mitmproxy is not required 12:54:17 INFO - Running post-action listener: _resource_record_post_action 12:54:17 INFO - [mozharness: 2017-09-27 19:54:17.851713Z] Finished setup-mitmproxy step (success) 12:54:17 INFO - [mozharness: 2017-09-27 19:54:17.851936Z] Running run-tests step. 12:54:17 INFO - Running pre-action listener: _resource_record_pre_action 12:54:17 INFO - Running pre-action listener: _set_gcov_prefix 12:54:17 INFO - Running main action method: run_tests 12:54:17 WARNING - Try message not found. 12:54:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:54:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:54:17 INFO - Python 2.7.3 12:54:17 INFO - Return code: 0 12:54:17 INFO - grabbing minidump binary from tooltool 12:54: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')]} 12:54:17 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 0xfb3090>, '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 0xfb3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfadf90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:54:17 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 12:54:17 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 12:54:17 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 12:54:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:54:17 INFO - Return code: 0 12:54:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:54:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:54:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:54:17 INFO - ENV: RUST_BACKTRACE is now full 12:54:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:54:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:54:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ADu_DyoQRUasrawy0ZNw_A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 12:54:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ADu_DyoQRUasrawy0ZNw_A/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-043 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 12:54:17 INFO - Using env: {'DISPLAY': ':0', 12:54:17 INFO - 'HOME': '/home/cltbld', 12:54:17 INFO - 'LANG': 'en_US.UTF-8', 12:54:17 INFO - 'LANGUAGE': 'en_US:en', 12:54:17 INFO - 'LOGNAME': 'cltbld', 12:54:17 INFO - 'MAIL': '/var/mail/cltbld', 12:54:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:54:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:54:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:17 INFO - 'MOZ_NO_REMOTE': '1', 12:54:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:54:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:17 INFO - 'NO_EM_RESTART': '1', 12:54:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:17 INFO - 'PWD': '/builds/slave/test', 12:54:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:54:17 INFO - 'RUST_BACKTRACE': 'full', 12:54:17 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 12:54:17 INFO - 'SHELL': '/bin/bash', 12:54:17 INFO - 'SHLVL': '1', 12:54:17 INFO - 'TERM': 'linux', 12:54:17 INFO - 'TMOUT': '86400', 12:54:17 INFO - 'USER': 'cltbld', 12:54:17 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1506542003.74556-1805683729', 12:54:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:17 INFO - '_': '/tools/buildbot/bin/python'} 12:54:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ADu_DyoQRUasrawy0ZNw_A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 12:54:18 INFO - mozversion application_buildid: 20170927183931 12:54:18 INFO - mozversion application_changeset: b21b199adf72fc9b208073fc887e2e50fa82681a 12:54:18 INFO - mozversion application_display_name: Firefox 12:54:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:54:18 INFO - mozversion application_name: Firefox 12:54:18 INFO - mozversion application_remotingname: firefox 12:54:18 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 12:54:18 INFO - mozversion application_vendor: Mozilla 12:54:18 INFO - mozversion application_version: 57.0 12:54:18 INFO - mozversion platform_buildid: 20170927183931 12:54:18 INFO - mozversion platform_changeset: b21b199adf72fc9b208073fc887e2e50fa82681a 12:54:18 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 12:54:18 INFO - mozversion platform_version: 57.0 12:54:18 INFO - using testdate: 1506542058 12:54:18 INFO - actual date: 1506542058 12:54:18 INFO - starting webserver on 'localhost:38195' 12:54:18 INFO - SUITE-START | Running 2 tests 12:54:18 INFO - TEST-START | dromaeo_css 12:54:18 INFO - Initialising browser for dromaeo_css test... 12:54:18 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:38195/getInfo.html -profile /tmp/tmpg06Hsi/profile 12:54:18 INFO - TEST-INFO | started process 26019 (/builds/slave/test/build/application/firefox/firefox http://localhost:38195/getInfo.html) 12:54:23 INFO - TEST-INFO | 26019: exit 0 12:54:23 INFO - Browser initialized. 12:54:23 INFO - Running cycle 1/1 for dromaeo_css test... 12:54:23 INFO - Using env: {'DISPLAY': ':0', 12:54:23 INFO - 'HOME': '/home/cltbld', 12:54:23 INFO - 'JSGC_DISABLE_POISONING': '1', 12:54:23 INFO - 'LANG': 'en_US.UTF-8', 12:54:23 INFO - 'LANGUAGE': 'en_US:en', 12:54:23 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 12:54:23 INFO - 'LOGNAME': 'cltbld', 12:54:23 INFO - 'MAIL': '/var/mail/cltbld', 12:54:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:54:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:54:23 INFO - 'MOZ_CRASHREPORTER': '1', 12:54:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:23 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 12:54:23 INFO - 'MOZ_NO_REMOTE': '1', 12:54:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:54:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:23 INFO - 'NO_EM_RESTART': '1', 12:54:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:23 INFO - 'PWD': '/builds/slave/test', 12:54:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:54:23 INFO - 'RUST_BACKTRACE': 'full', 12:54:23 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 12:54:23 INFO - 'SHELL': '/bin/bash', 12:54:23 INFO - 'SHLVL': '1', 12:54:23 INFO - 'TERM': 'linux', 12:54:23 INFO - 'TMOUT': '86400', 12:54:23 INFO - 'USER': 'cltbld', 12:54:23 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1506542003.74556-1805683729', 12:54:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:23 INFO - '_': '/tools/buildbot/bin/python'} 12:54:23 INFO - TEST-INFO | started process 26208 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpg06Hsi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 12:54:24 INFO - PID 26208 | 12:54:24 INFO - PID 26208 | (/builds/slave/test/build/application/firefox/firefox:26256): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 12:54:24 INFO - PID 26208 | 12:54:35 INFO - PID 26208 | RSS: Main: 141242368 12:54:35 INFO - PID 26208 | 12:57:32 INFO - PID 26208 | Cycle 1(1): loaded http://localhost:38195/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38195/tests/dromaeo/cssquery-ext.html) 12:57:33 INFO - PID 26208 | RSS: Main: 145100800 12:57:33 INFO - PID 26208 | 13:00:35 INFO - PID 26208 | Cycle 1(1): loaded http://localhost:38195/tests/dromaeo/cssquery-ext.html (next: http://localhost:38195/tests/dromaeo/cssquery-jquery.html) 13:00:35 INFO - PID 26208 | RSS: Main: 144109568 13:00:35 INFO - PID 26208 | 13:03:37 INFO - PID 26208 | Cycle 1(1): loaded http://localhost:38195/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38195/tests/dromaeo/cssquery-mootools.html) 13:03:37 INFO - PID 26208 | RSS: Main: 144674816 13:03:37 INFO - PID 26208 | 13:06:39 INFO - PID 26208 | Cycle 1(1): loaded http://localhost:38195/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38195/tests/dromaeo/cssquery-prototype.html) 13:06:39 INFO - PID 26208 | RSS: Main: 144297984 13:06:39 INFO - PID 26208 | 13:09:42 INFO - PID 26208 | Cycle 1(1): loaded http://localhost:38195/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38195/tests/dromaeo/cssquery-yui.html) 13:09:43 INFO - PID 26208 | RSS: Main: 145297408 13:09:43 INFO - PID 26208 | 13:12:44 INFO - PID 26208 | Cycle 1(1): loaded http://localhost:38195/tests/dromaeo/cssquery-yui.html (next: http://localhost:38195/tests/dromaeo/cssquery-dojo.html) 13:12:45 INFO - PID 26208 | RSS: Main: 148230144 13:12:45 INFO - PID 26208 | 13:12:45 INFO - PID 26208 | __start_tp_report 13:12:45 INFO - PID 26208 | _x_x_mozilla_page_load 13:12:45 INFO - PID 26208 | _x_x_mozilla_page_load_details 13:12:45 INFO - PID 26208 | |i|pagename|runs| 13:12:45 INFO - PID 26208 | |0;dojo.html;3971.2057588482307;3973;3985.38226574881;3987.2224916141354;4003.559608443071;6254.781082662108;6299.149614802006;6366.808995730135;6370.108184854124;6431;6321.494280457564;6380.744770209186;6384.201974753156;6436.839079023027;6463.289038205806;5541.944580554204;5760.9711951440395;5797.4202579742005;5812.709364531777;5821.53427725781;5679.7160141992945;5787.768489260425;5788.073908174693;5834.037383831663;5850.6782126983;5699.03116470199;5740.7703691852275;5750.309962804469;5765.164051212571;5777.855553611173;5742.966266072105;5743.167240750068;5801.854953626151;5804.535637149018;5827.329857066428;5686.857828554278;5728.283964504437;5738.167965645;5740.569457290678;5847.26909136358;6142.447179753844;6231.034189700604;6233.812985610439;6251.718672659741;6307.810765677037;6890.621015844126;6891.620960847152;6914.757983470555;6923.2038315593845;6930.44556435484;6825.317468253184;6916;6995.580265184105;7005.82485437863;7006.404455621278;6310.211223597051;6357.618542887441;6374.617522948638;6375.2987171411105;6375.904361434582;6854.760083397057;6943.51395402317;6947.235804061549;6949.7567585134275;6960.443164546824;6702.631355275506;6720.764773232913;6777.2545020047755;6783.050372947791;6797.0823938767635;6825.965870170717;6847.246802851682;6927.861442771116;6928.688209030605;6932.61870597122;6684;6738.157730283715;6772.661366931634;6804;6813.1142951415995;6723.0923825283935;6845.863082738318;6858.3141685831015;6880.759173428906;6889.827754306182;5030.924536131961;5048.1418158913075;5097.260897169889;5097.260897169964;5101.9744901276;4621.260598304255;4634.420697412824;4640.489546149921;4671.04243630055;4733.455652599926;6413.518986076063;6496.967515162394;6529.444997175293;6531.216254049545;6533.346665333429;6830;6838.863222735617;6912.792616221522;6923.307669233036;6923.723051078001;6317.178766760292;6422.325655806073;6427.871442571216;6450.032495125769;6482.740690372427;5628.71856407178;5638.097904335286;5644.971775141098;5718.971405142947;5739.282589676291;7178.856422871618;7259.782206533707;7289.562626242337;7291.781246562611;7293.197748247689;6750.189977202767;6824.3516865898655;6909.930900690929;6929.064576282339;6943.409810166192;6939.618320992394;7119.67961441726;7124.430045596237;7132.786016419515;7230.168530619047;6853.7943861684225;6880.105586273752;6888.827779305558;6897.862042759217;6903.792886213421;6754.425873800782;6806.625635589892;6909.654517274217;6937.861242775217;7007.089078419773;6598.90101648466;6623.370779775913;6625.635590042594;6629.270780214269;6629.602223866584;6598.27418983921;6614.140161778938;6682.732690692318;6682.732690692318;6688.2977287386075;6565.212174539086;6568.967155164193;6635.701393437404;6651.301613330724;6658.0345849852465;6656.334366563305;6681.732730690718;6706.396424321834;6709.7651582194385;6805.2854450283985;6430.2605200400685;6448.129502517288;6493.188351456068;6496.480281577368;6580.5722628029025 13:12:45 INFO - PID 26208 | |1;ext.html;918.1782304837171;928.6563971330601;961.6586111930264;982.0866594067519;988.4859872866108;45222.77388613056;45959.77020114899;46105.308420373636;46106.538934610646;46160.769196153975;41736.791316043375;42007.57992420075;42049.789751051205;42061;42070.36894446578;5684.772609095631;5684.914726279109;5685.800996965087;5687.573431992617;5859.882802343961;7866.842663146734;7949.165337639552;7957;7957.5225486471;7958.681652733883;8742.388032837704;8966.64133434665;8983.95508022459;9004.324675649319;9004.369694121415;8899.911000889973;8963.327750418712;8965.865512017324;8972.775680608038;8973.461592304482;8715.215630593277;8745.212930836191;8777.210051095431;8783.868241976375;8799.34004949625;42704.35943460851;42946.141077178596;42954.57045429537;42975.35536966948;43055.78472107651;3780.3951367781297;3821.7515861468914;3825.617438256152;3836.6547010769164;3839.021049632354;30606.234844128852;30681;30717.232069198224;30809.691903080908;30948;4904.901901961941;4913.287573301887;4917.582005529534;4940.90118197634;4963.106640804654;241434;241648;241796;242234;242434;55048.89902201934;55296;55340.723296384065;55438;55618.44381556214;56465.7176714122;56590.43409565934;56787.43212567904;56889;57029.42970570241;16976.40582579604;17145.22846471912;17395.91302043482;17403.56491087733;17412.564685882953;14077.436902523988;14100.85899141016;14105.083169593943;14127.85872141286;14129.293535323399;15770.448034318744;15919.602009949844;15920.363185472683;15984.120873351845;16012.279447424893;5906.464319277019;6003.879922401527;6055.788047418319;6071.605345652519;6196.132541444202;1115.81031224692;1120.4789772755707;1130.37829193943;1139.0602752729033;1146.2950285574311;26568.468630627278;26710.93156273766;26776.866115669298;26798.866005670236;26877.328066798487;1225.730339325347;1233.2415564427993;1238.1766125526603;1241.7702724995725;1246.1526162209602;14086.859131408759;14137;14193.645009110693;14199;14297.78553321701;293121;293257;293890;294432;295596;58636;61605.69197154075;64991.35008649948;65130.34869651338;65527;1513.8646015488384;1536.43152033746;1551.8370571089872;1560.461640733945;1572.15103843923;31457.528137077505;31750.206244844063;32018.51972220465;32164.51753223657;32520.51219231761;42963.35554966616;43015.784921075196;43064.13871722485;43072.78463607662;43225.56774432341;239412;240348;240756;241470;241916;36198.8190059048;37650.43524347192;37665.62334376731;37686.81156594199;37722.62277377191;45441.77279113583;47082.29376559286;47223.52776472329;47305.29042064441;47344.28983565318;35261.64738352686;35295.29409411746;36116.819415902755;36142.4578631326;36363;35351;35427.291454170256;35551.46672799858;35565.644343557266;35771;41378.793106034274;41732.58267417408;41873.37189942214;42020.579794201665;42112.736617901515;34272.65727342795;34406.483902740976;34605.826970865994;34799.13002174865;35118.648813511536;25722.485550288515;26355.341116472242;26418.603720944586;26534;26869.059582914506 13:12:45 INFO - PID 26208 | |2;jquery.html;642.2821055512921;655.9376859198376;656.564147014576;661.5567569728281;662.5726406467826;23851.880740596294;24413.63379549306;24527.877360613173;24547.386315342126;24587.877060614715;26242.737572624315;26561.60157597633;26677.86661066697;26729.19812405631;26801;6523.282438931726;6656.267810540837;6675.065490831287;6689.799306020827;6707.932920670804;6500.187476565429;6580.736770529197;6597.769078082268;6606.108175396308;6609;6529.869402611945;6704.664766761667;6735.8652826943435;6740.5618634788825;6741.9325806742045;6669.133012708366;6724.966375168142;6731.192256929151;6744.763933262337;6752.797416077526;6282;6303.959846625301;6338.778142764981;6340.334264902165;6371.044343348489;28181;29557.26106847346;30061.098167055025;30437.847810760806;30548;2115.153938424627;2118.046878904484;2131.2753663754243;2135.562209746998;2139.828813694901;18223.63552728938;18636.16137273826;18667.62664746711;18688;18731.62536749271;2418.1657328221736;2489.65144879717;2508.686414198225;2525.6211568264907;2528.3047162030407;137782;144028;146708;151574.24212879085;151627;16072.196390180445;16077.758833617505;16215.513534593982;16639;16964.575885602713;26429.603555946676;26458.735412645627;26484.867575662385;26591.33521661935;26758.866205669237;11265.605703800327;11321.094312454983;11496.137789665809;11534.307941523535;11830.822537661941;10580.36517808934;10602.416867072385;10690.412027338416;10734.838977415346;10802.72993175177;9730;9836.557354919047;9943.254255930835;9998.200143988464;10249.231307651957;2950.173951293641;2997.730204281625;3023.289526961162;3036.3927214557175;3079.337942342407;1038.076112260089;1054.0882136951634;1061.8354155105972;1062.9574817007233;1084.0352086642895;21105.68341474879;21844.017019234172;21925.561488770134;22054.669179962315;22054.669179962315;1112.1992165640727;1121.3776354123377;1121.5401685308984;1125.1954852280658;1129.5989923577013;11520.366379849189;11761.235519691192;11844.763104737856;11950.223235489666;12113.939430302793;584375;589214;591253;636811;650881;127426;129641;131512.3424382872;133338;133483;1140.4411838199223;1195.1813008089487;1225.2709637765515;1242.8135779632946;1277.7763891318982;22131.225407110673;22565.548689026455;22572;22634.207802726825;22656.433589160402;65570.34429655642;66302;67054.66472667606;67449.66275168593;68596;84296.57851710702;84847.57576212079;84935;85141.57429212815;86301.56849215714;15815.209239538208;16158.192090395669;16281;16284.592885177964;16286.67426651484;24334.51330973406;24815.379615509755;24974.62538061967;25197;25218.495630087662;19825.20699172017;20088.497787554843;20108.798912010694;20125.79874201298;20131.39605811828;16994.74507882358;17499.30002799874;17779.19993600317;17869.195886184894;18096;20131.39605811828;20262.18951241934;20588.970551472667;20766.896165519076;20797.37607871766;15916.681666366376;16059;16060.277287521856;16063;16070.598235044217;20070.39788806338;20227.898860505604;20280.188792448138;20423.38729838048;20436.080376383397 13:12:45 INFO - PID 26208 | |3;mootools.html;1430.9212993285369;1522.9263369324635;1529.2048134969816;1531.3950989359203;1535.9616009599752;17008.57478563035;17501.3874514392;17638.647227055484;17657.558561035963;17661.646767064653;17348.82651173488;17487.825121748778;17543.82456175438;17549.29802807886;17565.385211517598;2793.888244470219;2841.318083659922;2911.8980835670754;2912.490314195018;2914.1257622713206;2863.856807159644;2912.8397938113394;2914.227729651644;2916.5916771651987;2931.3551018775943;2803.8457884816326;2928.238657948938;2947.484190266695;2955.3055032067446;2971.851407429631;2849.772018238536;2860.556613724855;2870.2250392393935;2873.6063009440404;2889.8699558519916;2631.9603756516262;2647.1264482720658;2675.103840213531;2676.317539027555;2683.4633073385207;16955.237014334383;17335.306587736475;17357.913210433868;17360.39238626642;17369.2183851727;8489.787755306104;8731.214190722802;8745.169208925143;8748.125187481264;8749.212570868589;5183.974080129575;5226.451222621646;5238.13570760824;5321.866953326159;5336.759845806948;1911.7132430135591;1972.9013549322476;1986.294865322804;2005.6189324028387;2008.2770202727006;31380.529292060408;31397.686023139704;31539.684603153903;31677.20806979821;31701.682983170103;7072.575645461289;7096.680649370791;7110.57336559808;7189.712411503481;7232.0598322217775;20708.79291207099;20838.1664733412;20839.79160208409;20876.58246835055;20934.58130837375;7982.121966583672;8209.302209312274;8210.548419836847;8229.25936665703;8241.670333186605;7476.289752473506;7490.775276741707;7520.097588289331;7648.541087534654;7680.692772289158;5867.20792692981;6018.21763170785;6053.697315134225;6095.116208149793;6303.9684801575695;1583.7228485015075;1605.414023881275;1624.6507000994607;1642.0640235065898;1660.5848537865534;1024.4928760263717;1024.8667673202435;1035.2649618770606;1042.2339580408393;1051.4637534857277;9842.75393115178;10372.325798823053;10465.9476702616;10475.214358923111;10652.041316281571;1092.1372116028408;1102.311055590256;1113.1595645287919;1120.2438354110943;1126.9267497612793;5312.096943519611;5388.191771234347;5455.936092462011;5465.480779325958;5468.28912241414;25474.23577292684;26054.609180862302;26409.603855942176;26472.60291095635;26859.462810743677;26203.868980654974;26418.207453776417;26681.46637067248;26790.196294111207;26895.462090758076;11205.60780372683;11614.941925290319;11943.104267179997;12039.819402708967;12049.277043377426;9751.414915105117;9842.09658150833;9956.303058785816;10008.599656013677;10028.047335503115;21417.357479275648;21426.250081247083;22217.00023498914;22264.22075227359;22631.434214144778;22529.66205506886;23140.884295578413;23486.765132348457;23503;23828.404289892893;12831.615051548468;13009;13053.086283960032;13053.216806991612;13057.608271751862;16016.119113448873;16132.919335403249;16175.676486469969;16229.350825966829;16244.187790610185;11962.222455540363;12147.514099435924;12182.086343524448;12228.44971976281;12463.626091217278;11860.94069529647;11988.700282493008;12122.09084318662;12259.632211033684;12405;11516.596919107791;11571.190016699087;11571.479283432434;11746.353950532803;11755.588554400554;8247.505149691038;8285.254327110348;8309.584520773817;8392.790180245544;8490.872636910575;8403.873941890753;8409.159084091541;8450.704225352083;8453.915460845314;8505.532195729294 13:12:45 INFO - PID 26208 | |4;prototype.html;559.8096647139971;576.3314555116066;582.8717682109935;598.3896425645842;600.6396162302619;6191.690415479231;6273.717682704278;6336.619802811829;6361.650109243989;6383.340161681975;6294.937050629493;6300.684965751706;6309.810705678826;6327.145835312232;6333.271673757519;5278.551323137519;5282.815101471449;5302.655327403726;5310.8141215057485;5313.840584782443;4965.875853103666;5040.5967522598285;5087.084324821531;5089.745512724349;5227.398849132342;5020.573251273646;5067.29057931888;5101.872453188681;5105.030044291572;5109.233614957768;5040.949590504085;5063.544281014708;5071.8985620287385;5082.2122571001555;5084.51697088776;4654.976725116387;4658.301254811805;4663.953360466386;4669.182892993713;4673.392458980345;6261.342559031282;6262.6868656566985;6317.273513545955;6332.588381755171;6342;5845.795397161079;5892.23400957877;5956.277326670831;5957.165996760414;5983.970080149571;6662.300458451889;6718.137071184089;6729.798106056777;6732.798016059526;6766.8308292292595;4999.8250061248045;5118.948810511884;5132.204508301219;5151.124308867464;5158.380994280673;6801.897971530381;6870;6879.5184337095925;6932;6970.233274339818;5281.9207711884355;5289.338832645919;5293.708846013429;5315.574754019669;5326.387465441524;5309.601779866525;5317.308749862493;5353.892922141613;5369.946300537023;5382.515573598395;5918.496927761103;5931.406859314034;5969.313528944227;5976.5218782497295;5993.220881285405;6733.8989915151315;6759.898601520981;6764.526483146231;6772.627505487246;6789.1174147360525;1816.2281030561958;1822.1253798176683;1823.1340113446006;1834.3763120539081;1857.535616095976;1233.9321337326533;1237.7833879071127;1264.5321231144535;1271.3007845685022;1290.9225446473242;6339.5562310637815;6395.529028323419;6416.358364163546;6430.164078669836;6485.513586480938;6705.664716764142;6799.422049125879;6806.319368063154;6806.5235433520165;6814.557053791487;6017.615948331821;6259.843503912348;6305.684715764193;6307.6346370111205;6405.551611387252;3538.6815186633326;3559.252556963015;3560.768550044239;3592.191756854687;3595.856165753393;6940.479464040116;6984.755533556403;7017.3684368407085;7080.2919708028785;7116.573005619576;6900.482463815234;6941.965290173517;6953.756618518328;6954.513184077167;6994.720211191496;7000.369966703021;7032.824179395454;7102.715891364391;7107.857842843114;7123.180834203926;6650.667466626553;6683.799486015428;6689.0902457431175;6729.360710732472;6774.593524388552;6672.232693240146;6740.898886516608;6750.966245168939;6771.492138089761;6804.4556435484055;7090.574565526085;7136.571805691675;7155.248698886542;7197.172325182671;7238.203797582367;5184.0927837629015;5189.844304670866;5202.115640341075;5202.817901373585;5229.738513074407;6661.967395053774;6807;6807.591544507345;6809.250982392032;6916.135483064617;6400;6565.310642382672;6611.900821487778;6655.500837437308;6666.733330666719;6546.639934803631;6551.901721474086;6602.570832895846;6603.438707709898;6618.749625127287;6417.582857114273;6440.42036216724;6465.870682586228;6529.747237203157;6613;6682.231543372574;6689.431398331197;6691.899621505584;6715.4627629790475;6720.596764194164;6365.40864783804;6438.195225596801;6457.321981191907;6465.870682586416;6572.474202063728 13:12:45 INFO - PID 26208 | |5;yui.html;985.7979114281572;989.0752146742793;1015.8425444056164;1016.0652199976022;1023.8054769593774;17951.640967180665;18056.819431805678;18214.90892545537;21119.894400528014;21483.892580537115;19327.90336048318;19485.70771438426;19502.414927552196;20805.375838724864;21013.68479472809;1094.1520321750627;1114.799336119498;1116.3023110555903;1120.7422292872643;1123.2698745815203;1076.252004856625;1108.528875228029;1115.893990070942;1123.2867129372826;1127.408110741863;1166.9883301167008;1171.77736230116;1172.349346112907;1172.5368479450653;1172.724409763705;1172.349346112907;1174.6241202815102;1174.6358628825092;1174.7356844709914;1177.658479041077;861.7285555050139;862.9007664118644;863.2834747159842;863.4517081653132;864.7492227254089;19667.311644092388;19935;20017.599648007104;20030.69953950692;20073.297434589866;16934.06862622555;17158.22787974532;17177.055261960588;17179.484615461555;17186.140692965426;17671.469855904343;18297.908510457495;18360;18441.446756597325;18470.261189552537;3994.960050399517;4014.578469260715;4029.7783621900785;4031.4154447605224;4032.5765794591734;152600.2369988154;154570;155342;155548.22225888798;158416;15942.28259728315;16002.839971600368;16118.194090295437;16124.193790310437;16213.675726485404;24958.376040598767;29699.554506682416;30370;30370.240743981576;30465;9168.81662366749;9333.719988400358;9336.299777516713;9373.1564159226;9385.436873787457;4199.811008504625;4234.13200293939;4244.1723863846255;4254.276772948606;4276.87169384919;5800.738966746507;5916.704164791743;5917.378675239038;5957.672328022;5990.28116625999;1154.9720748533812;1187.602153278644;1189.1556994533805;1198.1553005131361;1200.4297958469658;705.7424040225384;716.183550752143;728.7631519756101;735.7351353512731;742.2466196810242;12393.504259829686;13030.739385212242;13387.531436399679;14046.1572305662;14158.575242742734;767.1982777997007;771.691323470605;779.5517577393022;789.7314912929517;794.1304271822345;6518.706658200393;6663.4669226461765;6702.296258892844;6770.119884414995;6787.762428314985;150301;151962;153612;155082.22458887633;156040;134120;135187;136240;136393;139882;119858.4007079959;120137.39931300287;120434.39782801205;120574.39712801379;122777.38611306886;12665.683357916127;12832.422540985492;12851.228926264454;12873.163244389085;12963.101788686314;57141;57764.4223557759;58160.70919645544;58484.4151558479;59507.70246148915;71622;72829;73056.63471682607;74213;75700.62149689216;16348.182590870647;16778.664426711643;17169.399071032454;17275.65448690994;17528.561785954942;19693;19747.506312342306;20036.198552057755;20113.6982945253;20298.188072476936;16980;17026.489205323862;17027.063511506985;17186.570335741206;17316.39392621252;16374.099424531765;16448.506544803677;16449.25978330954;16503.91748041252;16616.58458538498;20337.49156271105;20621.79378206259;20801.1679532817;20855.8957205213;20939.685904711136;13536.390862411412;13606.93196534011;13657.863421365659;13677.179369237878;13743.175409475463;15202.923985380003;15384.615384615474;15443.459478918634;15616.063036217864;15644.217789110726 13:12:45 INFO - PID 26208 | __end_tp_report 13:12:45 INFO - PID 26208 | __start_cc_report 13:12:45 INFO - PID 26208 | _x_x_mozilla_cycle_collect,259 13:12:45 INFO - PID 26208 | __end_cc_report 13:12:45 INFO - PID 26208 | __startTimestamp1506543165131__endTimestamp 13:12:45 INFO - PID 26208 | 13:12:45 INFO - PID 26208 | ------- Summary: start ------- 13:12:45 INFO - PID 26208 | Number of tests: 6 13:12:45 INFO - PID 26208 | 13:12:45 INFO - PID 26208 | [#0] dojo.html Cycles:165 Average:6348.26 Median:6598.27 stddev:724.17 (11.0%) stddev-sans-first:701.97 13:12:45 INFO - PID 26208 | Values: 3971.2 3973.0 3985.4 3987.2 4003.6 6254.8 6299.1 6366.8 6370.1 6431.0 6321.5 6380.7 6384.2 6436.8 6463.3 5541.9 5761.0 5797.4 5812.7 5821.5 5679.7 5787.8 5788.1 5834.0 5850.7 5699.0 5740.8 5750.3 5765.2 5777.9 5743.0 5743.2 5801.9 5804.5 5827.3 5686.9 5728.3 5738.2 5740.6 5847.3 6142.4 6231.0 6233.8 6251.7 6307.8 6890.6 6891.6 6914.8 6923.2 6930.4 6825.3 6916.0 6995.6 7005.8 7006.4 6310.2 6357.6 6374.6 6375.3 6375.9 6854.8 6943.5 6947.2 6949.8 6960.4 6702.6 6720.8 6777.3 6783.1 6797.1 6826.0 6847.2 6927.9 6928.7 6932.6 6684.0 6738.2 6772.7 6804.0 6813.1 6723.1 6845.9 6858.3 6880.8 6889.8 5030.9 5048.1 5097.3 5097.3 5102.0 4621.3 4634.4 4640.5 4671.0 4733.5 6413.5 6497.0 6529.4 6531.2 6533.3 6830.0 6838.9 6912.8 6923.3 6923.7 6317.2 6422.3 6427.9 6450.0 6482.7 5628.7 5638.1 5645.0 5719.0 5739.3 7178.9 7259.8 7289.6 7291.8 7293.2 6750.2 6824.4 6909.9 6929.1 6943.4 6939.6 7119.7 7124.4 7132.8 7230.2 6853.8 6880.1 6888.8 6897.9 6903.8 6754.4 6806.6 6909.7 6937.9 7007.1 6598.9 6623.4 6625.6 6629.3 6629.6 6598.3 6614.1 6682.7 6682.7 6688.3 6565.2 6569.0 6635.7 6651.3 6658.0 6656.3 6681.7 6706.4 6709.8 6805.3 6430.3 6448.1 6493.2 6496.5 6580.6 13:12:45 INFO - PID 26208 | 13:12:45 INFO - PID 26208 | [#1] ext.html Cycles:180 Average:44315.02 Median:3801.07 stddev:67674.96 (1780.4%) stddev-sans-first:67786.36 13:12:45 INFO - PID 26208 | Values: 918.2 928.7 961.7 982.1 988.5 45222.8 45959.8 46105.3 46106.5 46160.8 41736.8 42007.6 42049.8 42061.0 42070.4 5684.8 5684.9 5685.8 5687.6 5859.9 7866.8 7949.2 7957.0 7957.5 7958.7 8742.4 8966.6 8984.0 9004.3 9004.4 8899.9 8963.3 8965.9 8972.8 8973.5 8715.2 8745.2 8777.2 8783.9 8799.3 42704.4 42946.1 42954.6 42975.4 43055.8 3780.4 3821.8 3825.6 3836.7 3839.0 30606.2 30681.0 30717.2 30809.7 30948.0 4904.9 4913.3 4917.6 4940.9 4963.1 241434.0 241648.0 241796.0 242234.0 242434.0 55048.9 55296.0 55340.7 55438.0 55618.4 56465.7 56590.4 56787.4 56889.0 57029.4 16976.4 17145.2 17395.9 17403.6 17412.6 14077.4 14100.9 14105.1 14127.9 14129.3 15770.4 15919.6 15920.4 15984.1 16012.3 5906.5 6003.9 6055.8 6071.6 6196.1 1115.8 1120.5 1130.4 1139.1 1146.3 26568.5 26710.9 26776.9 26798.9 26877.3 1225.7 1233.2 1238.2 1241.8 1246.2 14086.9 14137.0 14193.6 14199.0 14297.8 293121.0 293257.0 293890.0 294432.0 295596.0 58636.0 61605.7 64991.4 65130.3 65527.0 1513.9 1536.4 1551.8 1560.5 1572.2 31457.5 31750.2 32018.5 32164.5 32520.5 42963.4 43015.8 43064.1 43072.8 43225.6 239412.0 240348.0 240756.0 241470.0 241916.0 36198.8 37650.4 37665.6 37686.8 37722.6 45441.8 47082.3 47223.5 47305.3 47344.3 35261.6 35295.3 36116.8 36142.5 36363.0 35351.0 35427.3 35551.5 35565.6 35771.0 41378.8 41732.6 41873.4 42020.6 42112.7 34272.7 34406.5 34605.8 34799.1 35118.6 25722.5 26355.3 26418.6 26534.0 26869.1 13:12:45 INFO - PID 26208 | 13:12:45 INFO - PID 26208 | [#2] jquery.html Cycles:180 Average:40301.28 Median:22092.95 stddev:102111.59 (462.2%) stddev-sans-first:102354.62 13:12:45 INFO - PID 26208 | Values: 642.3 655.9 656.6 661.6 662.6 23851.9 24413.6 24527.9 24547.4 24587.9 26242.7 26561.6 26677.9 26729.2 26801.0 6523.3 6656.3 6675.1 6689.8 6707.9 6500.2 6580.7 6597.8 6606.1 6609.0 6529.9 6704.7 6735.9 6740.6 6741.9 6669.1 6725.0 6731.2 6744.8 6752.8 6282.0 6304.0 6338.8 6340.3 6371.0 28181.0 29557.3 30061.1 30437.8 30548.0 2115.2 2118.0 2131.3 2135.6 2139.8 18223.6 18636.2 18667.6 18688.0 18731.6 2418.2 2489.7 2508.7 2525.6 2528.3 137782.0 144028.0 146708.0 151574.2 151627.0 16072.2 16077.8 16215.5 16639.0 16964.6 26429.6 26458.7 26484.9 26591.3 26758.9 11265.6 11321.1 11496.1 11534.3 11830.8 10580.4 10602.4 10690.4 10734.8 10802.7 9730.0 9836.6 9943.3 9998.2 10249.2 2950.2 2997.7 3023.3 3036.4 3079.3 1038.1 1054.1 1061.8 1063.0 1084.0 21105.7 21844.0 21925.6 22054.7 22054.7 1112.2 1121.4 1121.5 1125.2 1129.6 11520.4 11761.2 11844.8 11950.2 12113.9 584375.0 589214.0 591253.0 636811.0 650881.0 127426.0 129641.0 131512.3 133338.0 133483.0 1140.4 1195.2 1225.3 1242.8 1277.8 22131.2 22565.5 22572.0 22634.2 22656.4 65570.3 66302.0 67054.7 67449.7 68596.0 84296.6 84847.6 84935.0 85141.6 86301.6 15815.2 16158.2 16281.0 16284.6 16286.7 24334.5 24815.4 24974.6 25197.0 25218.5 19825.2 20088.5 20108.8 20125.8 20131.4 16994.7 17499.3 17779.2 17869.2 18096.0 20131.4 20262.2 20589.0 20766.9 20797.4 15916.7 16059.0 16060.3 16063.0 16070.6 20070.4 20227.9 20280.2 20423.4 20436.1 13:12:45 INFO - PID 26208 | 13:12:45 INFO - PID 26208 | [#3] mootools.html Cycles:180 Average:10737.63 Median:24651.32 stddev:8112.31 (32.9%) stddev-sans-first:8104.94 13:12:45 INFO - PID 26208 | Values: 1430.9 1522.9 1529.2 1531.4 1536.0 17008.6 17501.4 17638.6 17657.6 17661.6 17348.8 17487.8 17543.8 17549.3 17565.4 2793.9 2841.3 2911.9 2912.5 2914.1 2863.9 2912.8 2914.2 2916.6 2931.4 2803.8 2928.2 2947.5 2955.3 2971.9 2849.8 2860.6 2870.2 2873.6 2889.9 2632.0 2647.1 2675.1 2676.3 2683.5 16955.2 17335.3 17357.9 17360.4 17369.2 8489.8 8731.2 8745.2 8748.1 8749.2 5184.0 5226.5 5238.1 5321.9 5336.8 1911.7 1972.9 1986.3 2005.6 2008.3 31380.5 31397.7 31539.7 31677.2 31701.7 7072.6 7096.7 7110.6 7189.7 7232.1 20708.8 20838.2 20839.8 20876.6 20934.6 7982.1 8209.3 8210.5 8229.3 8241.7 7476.3 7490.8 7520.1 7648.5 7680.7 5867.2 6018.2 6053.7 6095.1 6304.0 1583.7 1605.4 1624.7 1642.1 1660.6 1024.5 1024.9 1035.3 1042.2 1051.5 9842.8 10372.3 10465.9 10475.2 10652.0 1092.1 1102.3 1113.2 1120.2 1126.9 5312.1 5388.2 5455.9 5465.5 5468.3 25474.2 26054.6 26409.6 26472.6 26859.5 26203.9 26418.2 26681.5 26790.2 26895.5 11205.6 11614.9 11943.1 12039.8 12049.3 9751.4 9842.1 9956.3 10008.6 10028.0 21417.4 21426.3 22217.0 22264.2 22631.4 22529.7 23140.9 23486.8 23503.0 23828.4 12831.6 13009.0 13053.1 13053.2 13057.6 16016.1 16132.9 16175.7 16229.4 16244.2 11962.2 12147.5 12182.1 12228.4 12463.6 11860.9 11988.7 12122.1 12259.6 12405.0 11516.6 11571.2 11571.5 11746.4 11755.6 8247.5 8285.3 8309.6 8392.8 8490.9 8403.9 8409.2 8450.7 8453.9 8505.5 13:12:45 INFO - PID 26208 | 13:12:45 INFO - PID 26208 | [#4] prototype.html Cycles:180 Average:5703.62 Median:6338.09 stddev:1585.84 (25.0%) stddev-sans-first:1542.57 13:12:45 INFO - PID 26208 | Values: 559.8 576.3 582.9 598.4 600.6 6191.7 6273.7 6336.6 6361.7 6383.3 6294.9 6300.7 6309.8 6327.1 6333.3 5278.6 5282.8 5302.7 5310.8 5313.8 4965.9 5040.6 5087.1 5089.7 5227.4 5020.6 5067.3 5101.9 5105.0 5109.2 5040.9 5063.5 5071.9 5082.2 5084.5 4655.0 4658.3 4664.0 4669.2 4673.4 6261.3 6262.7 6317.3 6332.6 6342.0 5845.8 5892.2 5956.3 5957.2 5984.0 6662.3 6718.1 6729.8 6732.8 6766.8 4999.8 5118.9 5132.2 5151.1 5158.4 6801.9 6870.0 6879.5 6932.0 6970.2 5281.9 5289.3 5293.7 5315.6 5326.4 5309.6 5317.3 5353.9 5369.9 5382.5 5918.5 5931.4 5969.3 5976.5 5993.2 6733.9 6759.9 6764.5 6772.6 6789.1 1816.2 1822.1 1823.1 1834.4 1857.5 1233.9 1237.8 1264.5 1271.3 1290.9 6339.6 6395.5 6416.4 6430.2 6485.5 6705.7 6799.4 6806.3 6806.5 6814.6 6017.6 6259.8 6305.7 6307.6 6405.6 3538.7 3559.3 3560.8 3592.2 3595.9 6940.5 6984.8 7017.4 7080.3 7116.6 6900.5 6942.0 6953.8 6954.5 6994.7 7000.4 7032.8 7102.7 7107.9 7123.2 6650.7 6683.8 6689.1 6729.4 6774.6 6672.2 6740.9 6751.0 6771.5 6804.5 7090.6 7136.6 7155.2 7197.2 7238.2 5184.1 5189.8 5202.1 5202.8 5229.7 6662.0 6807.0 6807.6 6809.3 6916.1 6400.0 6565.3 6611.9 6655.5 6666.7 6546.6 6551.9 6602.6 6603.4 6618.7 6417.6 6440.4 6465.9 6529.7 6613.0 6682.2 6689.4 6691.9 6715.5 6720.6 6365.4 6438.2 6457.3 6465.9 6572.5 13:12:45 INFO - PID 26208 | 13:12:45 INFO - PID 26208 | [#5] yui.html Cycles:180 Average:28428.70 Median:17296.02 stddev:42974.05 (248.5%) stddev-sans-first:43045.20 13:12:45 INFO - PID 26208 | Values: 985.8 989.1 1015.8 1016.1 1023.8 17951.6 18056.8 18214.9 21119.9 21483.9 19327.9 19485.7 19502.4 20805.4 21013.7 1094.2 1114.8 1116.3 1120.7 1123.3 1076.3 1108.5 1115.9 1123.3 1127.4 1167.0 1171.8 1172.3 1172.5 1172.7 1172.3 1174.6 1174.6 1174.7 1177.7 861.7 862.9 863.3 863.5 864.7 19667.3 19935.0 20017.6 20030.7 20073.3 16934.1 17158.2 17177.1 17179.5 17186.1 17671.5 18297.9 18360.0 18441.4 18470.3 3995.0 4014.6 4029.8 4031.4 4032.6 152600.2 154570.0 155342.0 155548.2 158416.0 15942.3 16002.8 16118.2 16124.2 16213.7 24958.4 29699.6 30370.0 30370.2 30465.0 9168.8 9333.7 9336.3 9373.2 9385.4 4199.8 4234.1 4244.2 4254.3 4276.9 5800.7 5916.7 5917.4 5957.7 5990.3 1155.0 1187.6 1189.2 1198.2 1200.4 705.7 716.2 728.8 735.7 742.2 12393.5 13030.7 13387.5 14046.2 14158.6 767.2 771.7 779.6 789.7 794.1 6518.7 6663.5 6702.3 6770.1 6787.8 150301.0 151962.0 153612.0 155082.2 156040.0 134120.0 135187.0 136240.0 136393.0 139882.0 119858.4 120137.4 120434.4 120574.4 122777.4 12665.7 12832.4 12851.2 12873.2 12963.1 57141.0 57764.4 58160.7 58484.4 59507.7 71622.0 72829.0 73056.6 74213.0 75700.6 16348.2 16778.7 17169.4 17275.7 17528.6 19693.0 19747.5 20036.2 20113.7 20298.2 16980.0 17026.5 17027.1 17186.6 17316.4 16374.1 16448.5 16449.3 16503.9 16616.6 20337.5 20621.8 20801.2 20855.9 20939.7 13536.4 13606.9 13657.9 13677.2 13743.2 15202.9 15384.6 15443.5 15616.1 15644.2 13:12:45 INFO - PID 26208 | -------- Summary: end -------- 13:12:45 INFO - PID 26208 | 13:12:45 INFO - TEST-INFO | 26208: exit 0 13:12:45 INFO - TEST-OK | dromaeo_css | took 1107490ms 13:12:45 INFO - TEST-START | kraken 13:12:45 INFO - Initialising browser for kraken test... 13:12:45 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:38195/getInfo.html -profile /tmp/tmpyApA6Y/profile 13:12:45 INFO - TEST-INFO | started process 26573 (/builds/slave/test/build/application/firefox/firefox http://localhost:38195/getInfo.html) 13:12:51 INFO - TEST-INFO | 26573: exit 0 13:12:51 INFO - Browser initialized. 13:12:51 INFO - Running cycle 1/1 for kraken test... 13:12:51 INFO - Using env: {'DISPLAY': ':0', 13:12:51 INFO - 'HOME': '/home/cltbld', 13:12:51 INFO - 'JSGC_DISABLE_POISONING': '1', 13:12:51 INFO - 'LANG': 'en_US.UTF-8', 13:12:51 INFO - 'LANGUAGE': 'en_US:en', 13:12:51 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 13:12:51 INFO - 'LOGNAME': 'cltbld', 13:12:51 INFO - 'MAIL': '/var/mail/cltbld', 13:12:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:12:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:12:51 INFO - 'MOZ_CRASHREPORTER': '1', 13:12:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:12:51 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 13:12:51 INFO - 'MOZ_NO_REMOTE': '1', 13:12:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:12:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:12:51 INFO - 'NO_EM_RESTART': '1', 13:12:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:12:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:12:51 INFO - 'PWD': '/builds/slave/test', 13:12:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:12:51 INFO - 'RUST_BACKTRACE': 'full', 13:12:51 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 13:12:51 INFO - 'SHELL': '/bin/bash', 13:12:51 INFO - 'SHLVL': '1', 13:12:51 INFO - 'TERM': 'linux', 13:12:51 INFO - 'TMOUT': '86400', 13:12:51 INFO - 'USER': 'cltbld', 13:12:51 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1506542003.74556-1805683729', 13:12:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:12:51 INFO - '_': '/tools/buildbot/bin/python'} 13:12:51 INFO - TEST-INFO | started process 26765 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyApA6Y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 13:12:52 INFO - PID 26765 | 13:12:52 INFO - PID 26765 | (/builds/slave/test/build/application/firefox/firefox:26814): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 13:12:52 INFO - PID 26765 | 13:13:02 INFO - PID 26765 | RSS: Main: 141447168 13:13:02 INFO - PID 26765 | 13:13:04 INFO - PID 26765 | Cycle 1(1): loaded http://localhost:38195/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38195/tests/kraken/driver.html?testName=audio-beat-detection) 13:13:05 INFO - PID 26765 | RSS: Main: 147443712 13:13:05 INFO - PID 26765 | 13:13:08 INFO - PID 26765 | Cycle 1(1): loaded http://localhost:38195/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38195/tests/kraken/driver.html?testName=audio-dft) 13:13:08 INFO - PID 26765 | RSS: Main: 147816448 13:13:08 INFO - PID 26765 | 13:13:11 INFO - PID 26765 | Cycle 1(1): loaded http://localhost:38195/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38195/tests/kraken/driver.html?testName=audio-fft) 13:13:12 INFO - PID 26765 | RSS: Main: 149872640 13:13:12 INFO - PID 26765 | 13:13:14 INFO - PID 26765 | Cycle 1(1): loaded http://localhost:38195/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38195/tests/kraken/driver.html?testName=audio-oscillator) 13:13:14 INFO - PID 26765 | RSS: Main: 149524480 13:13:14 INFO - PID 26765 | 13:13:17 INFO - PID 26765 | Cycle 1(1): loaded http://localhost:38195/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38195/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:13:17 INFO - PID 26765 | RSS: Main: 149053440 13:13:17 INFO - PID 26765 | 13:13:20 INFO - PID 26765 | Cycle 1(1): loaded http://localhost:38195/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38195/tests/kraken/driver.html?testName=imaging-darkroom) 13:13:21 INFO - PID 26765 | RSS: Main: 150110208 13:13:21 INFO - PID 26765 | 13:13:24 INFO - PID 26765 | Cycle 1(1): loaded http://localhost:38195/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38195/tests/kraken/driver.html?testName=imaging-desaturate) 13:13:25 INFO - PID 26765 | RSS: Main: 150786048 13:13:25 INFO - PID 26765 | 13:13:28 INFO - PID 26765 | Cycle 1(1): loaded http://localhost:38195/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38195/tests/kraken/driver.html?testName=json-parse-financial) 13:13:28 INFO - PID 26765 | RSS: Main: 151957504 13:13:28 INFO - PID 26765 | 13:13:30 INFO - PID 26765 | Cycle 1(1): loaded http://localhost:38195/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38195/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:13:30 INFO - PID 26765 | RSS: Main: 151920640 13:13:30 INFO - PID 26765 | 13:13:32 INFO - PID 26765 | Cycle 1(1): loaded http://localhost:38195/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38195/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:13:33 INFO - PID 26765 | RSS: Main: 152039424 13:13:33 INFO - PID 26765 | 13:13:35 INFO - PID 26765 | Cycle 1(1): loaded http://localhost:38195/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38195/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:13:35 INFO - PID 26765 | RSS: Main: 148873216 13:13:35 INFO - PID 26765 | 13:13:38 INFO - PID 26765 | Cycle 1(1): loaded http://localhost:38195/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38195/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:13:38 INFO - PID 26765 | RSS: Main: 148688896 13:13:38 INFO - PID 26765 | 13:13:41 INFO - PID 26765 | Cycle 1(1): loaded http://localhost:38195/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38195/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:13:42 INFO - PID 26765 | RSS: Main: 149356544 13:13:42 INFO - PID 26765 | 13:13:43 INFO - PID 26765 | Cycle 1(1): loaded http://localhost:38195/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38195/tests/kraken/driver.html?testName=ai-astar) 13:13:44 INFO - PID 26765 | RSS: Main: 150675456 13:13:44 INFO - PID 26765 | 13:13:44 INFO - PID 26765 | __start_tp_report 13:13:44 INFO - PID 26765 | _x_x_mozilla_page_load 13:13:44 INFO - PID 26765 | _x_x_mozilla_page_load_details 13:13:44 INFO - PID 26765 | |i|pagename|runs| 13:13:44 INFO - PID 26765 | |0;ai-astar;107;107;106;105;107;106;107;105;107;106 13:13:44 INFO - PID 26765 | |1;audio-beat-detection;111;110;122;109;110;110;112;139;110;111 13:13:44 INFO - PID 26765 | |2;audio-dft;163;162;162;160;163;163;163;161;162;161 13:13:44 INFO - PID 26765 | |3;audio-fft;76;81;73;75;74;76;73;74;74;75 13:13:44 INFO - PID 26765 | |4;audio-oscillator;77;77;76;81;76;77;76;78;77;77 13:13:44 INFO - PID 26765 | |5;imaging-gaussian-blur;114;114;114;114;113;113;114;114;116;114 13:13:44 INFO - PID 26765 | |6;imaging-darkroom;149;148;148;148;149;149;148;148;148;148 13:13:44 INFO - PID 26765 | |7;imaging-desaturate;94;94;94;94;94;94;94;94;97;96 13:13:44 INFO - PID 26765 | |8;json-parse-financial;49;45;44;43;43;42;43;42;46;44 13:13:44 INFO - PID 26765 | |9;json-stringify-tinderbox;46;46;45;46;45;46;46;46;45;45 13:13:44 INFO - PID 26765 | |10;stanford-crypto-aes;70;69;68;71;68;70;71;68;70;75 13:13:44 INFO - PID 26765 | |11;stanford-crypto-ccm;101;105;108;109;106;104;106;106;100;108 13:13:44 INFO - PID 26765 | |12;stanford-crypto-pbkdf2;153;155;150;147;149;155;152;154;161;146 13:13:44 INFO - PID 26765 | |13;stanford-crypto-sha256-iterative;60;62;66;61;58;58;57;60;58;59 13:13:44 INFO - PID 26765 | __end_tp_report 13:13:44 INFO - PID 26765 | __start_cc_report 13:13:44 INFO - PID 26765 | _x_x_mozilla_cycle_collect,658 13:13:44 INFO - PID 26765 | __end_cc_report 13:13:44 INFO - PID 26765 | __startTimestamp1506543223995__endTimestamp 13:13:44 INFO - PID 26765 | 13:13:44 INFO - PID 26765 | ------- Summary: start ------- 13:13:44 INFO - PID 26765 | Number of tests: 14 13:13:44 INFO - PID 26765 | 13:13:44 INFO - PID 26765 | [#0] ai-astar Cycles:10 Average:106.30 Median:107.00 stddev:0.82 (0.8%) stddev-sans-first:0.83 13:13:44 INFO - PID 26765 | Values: 107.0 107.0 106.0 105.0 107.0 106.0 107.0 105.0 107.0 106.0 13:13:44 INFO - PID 26765 | 13:13:44 INFO - PID 26765 | [#1] audio-beat-detection Cycles:10 Average:114.40 Median:111.00 stddev:9.42 (8.5%) stddev-sans-first:9.91 13:13:44 INFO - PID 26765 | Values: 111.0 110.0 122.0 109.0 110.0 110.0 112.0 139.0 110.0 111.0 13:13:44 INFO - PID 26765 | 13:13:44 INFO - PID 26765 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.50 stddev:1.05 (0.6%) stddev-sans-first:1.05 13:13:44 INFO - PID 26765 | Values: 163.0 162.0 162.0 160.0 163.0 163.0 163.0 161.0 162.0 161.0 13:13:44 INFO - PID 26765 | 13:13:44 INFO - PID 26765 | [#3] audio-fft Cycles:10 Average:75.10 Median:75.00 stddev:2.33 (3.1%) stddev-sans-first:2.45 13:13:44 INFO - PID 26765 | Values: 76.0 81.0 73.0 75.0 74.0 76.0 73.0 74.0 74.0 75.0 13:13:44 INFO - PID 26765 | 13:13:44 INFO - PID 26765 | [#4] audio-oscillator Cycles:10 Average:77.20 Median:77.00 stddev:1.48 (1.9%) stddev-sans-first:1.56 13:13:44 INFO - PID 26765 | Values: 77.0 77.0 76.0 81.0 76.0 77.0 76.0 78.0 77.0 77.0 13:13:44 INFO - PID 26765 | 13:13:44 INFO - PID 26765 | [#5] imaging-gaussian-blur Cycles:10 Average:114.00 Median:114.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 13:13:44 INFO - PID 26765 | Values: 114.0 114.0 114.0 114.0 113.0 113.0 114.0 114.0 116.0 114.0 13:13:44 INFO - PID 26765 | 13:13:44 INFO - PID 26765 | [#6] imaging-darkroom Cycles:10 Average:148.30 Median:148.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 13:13:44 INFO - PID 26765 | Values: 149.0 148.0 148.0 148.0 149.0 149.0 148.0 148.0 148.0 148.0 13:13:44 INFO - PID 26765 | 13:13:44 INFO - PID 26765 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:94.00 stddev:1.08 (1.1%) stddev-sans-first:1.13 13:13:44 INFO - PID 26765 | Values: 94.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 97.0 96.0 13:13:44 INFO - PID 26765 | 13:13:44 INFO - PID 26765 | [#8] json-parse-financial Cycles:10 Average:44.10 Median:44.00 stddev:2.13 (4.8%) stddev-sans-first:1.33 13:13:44 INFO - PID 26765 | Values: 49.0 45.0 44.0 43.0 43.0 42.0 43.0 42.0 46.0 44.0 13:13:44 INFO - PID 26765 | 13:13:44 INFO - PID 26765 | [#9] json-stringify-tinderbox Cycles:10 Average:45.60 Median:46.00 stddev:0.52 (1.1%) stddev-sans-first:0.53 13:13:44 INFO - PID 26765 | Values: 46.0 46.0 45.0 46.0 45.0 46.0 46.0 46.0 45.0 45.0 13:13:44 INFO - PID 26765 | 13:13:44 INFO - PID 26765 | [#10] stanford-crypto-aes Cycles:10 Average:70.00 Median:70.00 stddev:2.11 (3.0%) stddev-sans-first:2.24 13:13:44 INFO - PID 26765 | Values: 70.0 69.0 68.0 71.0 68.0 70.0 71.0 68.0 70.0 75.0 13:13:44 INFO - PID 26765 | 13:13:44 INFO - PID 26765 | [#11] stanford-crypto-ccm Cycles:10 Average:105.30 Median:106.00 stddev:2.95 (2.8%) stddev-sans-first:2.68 13:13:44 INFO - PID 26765 | Values: 101.0 105.0 108.0 109.0 106.0 104.0 106.0 106.0 100.0 108.0 13:13:44 INFO - PID 26765 | 13:13:44 INFO - PID 26765 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.20 Median:153.50 stddev:4.44 (2.9%) stddev-sans-first:4.70 13:13:44 INFO - PID 26765 | Values: 153.0 155.0 150.0 147.0 149.0 155.0 152.0 154.0 161.0 146.0 13:13:44 INFO - PID 26765 | 13:13:44 INFO - PID 26765 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:59.90 Median:60.00 stddev:2.64 (4.4%) stddev-sans-first:2.80 13:13:44 INFO - PID 26765 | Values: 60.0 62.0 66.0 61.0 58.0 58.0 57.0 60.0 58.0 59.0 13:13:44 INFO - PID 26765 | -------- Summary: end -------- 13:13:44 INFO - PID 26765 | 13:13:44 INFO - PID 26765 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 13:13:44 INFO - TEST-INFO | 26765: exit 0 13:13:44 INFO - TEST-OK | kraken | took 58918ms 13:13:44 INFO - SUITE-END | took 1166s 13:13:44 INFO - Completed test suite (00:19:26) 13:13:44 INFO - javascript benchmark 13:13:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9205.327511597206, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3971.2057588482307, 3973.0, 3985.38226574881, 3987.2224916141354, 4003.559608443071, 6254.781082662108, 6299.149614802006, 6366.808995730135, 6370.108184854124, 6431.0, 6321.494280457564, 6380.744770209186, 6384.201974753156, 6436.839079023027, 6463.289038205806, 5541.944580554204, 5760.9711951440395, 5797.4202579742005, 5812.709364531777, 5821.53427725781, 5679.7160141992945, 5787.768489260425, 5788.073908174693, 5834.037383831663, 5850.6782126983, 5699.03116470199, 5740.7703691852275, 5750.309962804469, 5765.164051212571, 5777.855553611173, 5742.966266072105, 5743.167240750068, 5801.854953626151, 5804.535637149018, 5827.329857066428, 5686.857828554278, 5728.283964504437, 5738.167965645, 5740.569457290678, 5847.26909136358, 6142.447179753844, 6231.034189700604, 6233.812985610439, 6251.718672659741, 6307.810765677037, 6890.621015844126, 6891.620960847152, 6914.757983470555, 6923.2038315593845, 6930.44556435484, 6825.317468253184, 6916.0, 6995.580265184105, 7005.82485437863, 7006.404455621278, 6310.211223597051, 6357.618542887441, 6374.617522948638, 6375.2987171411105, 6375.904361434582, 6854.760083397057, 6943.51395402317, 6947.235804061549, 6949.7567585134275, 6960.443164546824, 6702.631355275506, 6720.764773232913, 6777.2545020047755, 6783.050372947791, 6797.0823938767635, 6825.965870170717, 6847.246802851682, 6927.861442771116, 6928.688209030605, 6932.61870597122, 6684.0, 6738.157730283715, 6772.661366931634, 6804.0, 6813.1142951415995, 6723.0923825283935, 6845.863082738318, 6858.3141685831015, 6880.759173428906, 6889.827754306182, 5030.924536131961, 5048.1418158913075, 5097.260897169889, 5097.260897169964, 5101.9744901276, 4621.260598304255, 4634.420697412824, 4640.489546149921, 4671.04243630055, 4733.455652599926, 6413.518986076063, 6496.967515162394, 6529.444997175293, 6531.216254049545, 6533.346665333429, 6830.0, 6838.863222735617, 6912.792616221522, 6923.307669233036, 6923.723051078001, 6317.178766760292, 6422.325655806073, 6427.871442571216, 6450.032495125769, 6482.740690372427, 5628.71856407178, 5638.097904335286, 5644.971775141098, 5718.971405142947, 5739.282589676291, 7178.856422871618, 7259.782206533707, 7289.562626242337, 7291.781246562611, 7293.197748247689, 6750.189977202767, 6824.3516865898655, 6909.930900690929, 6929.064576282339, 6943.409810166192, 6939.618320992394, 7119.67961441726, 7124.430045596237, 7132.786016419515, 7230.168530619047, 6853.7943861684225, 6880.105586273752, 6888.827779305558, 6897.862042759217, 6903.792886213421, 6754.425873800782, 6806.625635589892, 6909.654517274217, 6937.861242775217, 7007.089078419773, 6598.90101648466, 6623.370779775913, 6625.635590042594, 6629.270780214269, 6629.602223866584, 6598.27418983921, 6614.140161778938, 6682.732690692318, 6682.732690692318, 6688.2977287386075, 6565.212174539086, 6568.967155164193, 6635.701393437404, 6651.301613330724, 6658.0345849852465, 6656.334366563305, 6681.732730690718, 6706.396424321834, 6709.7651582194385, 6805.2854450283985, 6430.2605200400685, 6448.129502517288, 6493.188351456068, 6496.480281577368, 6580.5722628029025], "value": 6301.17810835362, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [918.1782304837171, 928.6563971330601, 961.6586111930264, 982.0866594067519, 988.4859872866108, 45222.77388613056, 45959.77020114899, 46105.308420373636, 46106.538934610646, 46160.769196153975, 41736.791316043375, 42007.57992420075, 42049.789751051205, 42061.0, 42070.36894446578, 5684.772609095631, 5684.914726279109, 5685.800996965087, 5687.573431992617, 5859.882802343961, 7866.842663146734, 7949.165337639552, 7957.0, 7957.5225486471, 7958.681652733883, 8742.388032837704, 8966.64133434665, 8983.95508022459, 9004.324675649319, 9004.369694121415, 8899.911000889973, 8963.327750418712, 8965.865512017324, 8972.775680608038, 8973.461592304482, 8715.215630593277, 8745.212930836191, 8777.210051095431, 8783.868241976375, 8799.34004949625, 42704.35943460851, 42946.141077178596, 42954.57045429537, 42975.35536966948, 43055.78472107651, 3780.3951367781297, 3821.7515861468914, 3825.617438256152, 3836.6547010769164, 3839.021049632354, 30606.234844128852, 30681.0, 30717.232069198224, 30809.691903080908, 30948.0, 4904.901901961941, 4913.287573301887, 4917.582005529534, 4940.90118197634, 4963.106640804654, 241434.0, 241648.0, 241796.0, 242234.0, 242434.0, 55048.89902201934, 55296.0, 55340.723296384065, 55438.0, 55618.44381556214, 56465.7176714122, 56590.43409565934, 56787.43212567904, 56889.0, 57029.42970570241, 16976.40582579604, 17145.22846471912, 17395.91302043482, 17403.56491087733, 17412.564685882953, 14077.436902523988, 14100.85899141016, 14105.083169593943, 14127.85872141286, 14129.293535323399, 15770.448034318744, 15919.602009949844, 15920.363185472683, 15984.120873351845, 16012.279447424893, 5906.464319277019, 6003.879922401527, 6055.788047418319, 6071.605345652519, 6196.132541444202, 1115.81031224692, 1120.4789772755707, 1130.37829193943, 1139.0602752729033, 1146.2950285574311, 26568.468630627278, 26710.93156273766, 26776.866115669298, 26798.866005670236, 26877.328066798487, 1225.730339325347, 1233.2415564427993, 1238.1766125526603, 1241.7702724995725, 1246.1526162209602, 14086.859131408759, 14137.0, 14193.645009110693, 14199.0, 14297.78553321701, 293121.0, 293257.0, 293890.0, 294432.0, 295596.0, 58636.0, 61605.69197154075, 64991.35008649948, 65130.34869651338, 65527.0, 1513.8646015488384, 1536.43152033746, 1551.8370571089872, 1560.461640733945, 1572.15103843923, 31457.528137077505, 31750.206244844063, 32018.51972220465, 32164.51753223657, 32520.51219231761, 42963.35554966616, 43015.784921075196, 43064.13871722485, 43072.78463607662, 43225.56774432341, 239412.0, 240348.0, 240756.0, 241470.0, 241916.0, 36198.8190059048, 37650.43524347192, 37665.62334376731, 37686.81156594199, 37722.62277377191, 45441.77279113583, 47082.29376559286, 47223.52776472329, 47305.29042064441, 47344.28983565318, 35261.64738352686, 35295.29409411746, 36116.819415902755, 36142.4578631326, 36363.0, 35351.0, 35427.291454170256, 35551.46672799858, 35565.644343557266, 35771.0, 41378.793106034274, 41732.58267417408, 41873.37189942214, 42020.579794201665, 42112.736617901515, 34272.65727342795, 34406.483902740976, 34605.826970865994, 34799.13002174865, 35118.648813511536, 25722.485550288515, 26355.341116472242, 26418.603720944586, 26534.0, 26869.059582914506], "value": 19019.577554536405, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [642.2821055512921, 655.9376859198376, 656.564147014576, 661.5567569728281, 662.5726406467826, 23851.880740596294, 24413.63379549306, 24527.877360613173, 24547.386315342126, 24587.877060614715, 26242.737572624315, 26561.60157597633, 26677.86661066697, 26729.19812405631, 26801.0, 6523.282438931726, 6656.267810540837, 6675.065490831287, 6689.799306020827, 6707.932920670804, 6500.187476565429, 6580.736770529197, 6597.769078082268, 6606.108175396308, 6609.0, 6529.869402611945, 6704.664766761667, 6735.8652826943435, 6740.5618634788825, 6741.9325806742045, 6669.133012708366, 6724.966375168142, 6731.192256929151, 6744.763933262337, 6752.797416077526, 6282.0, 6303.959846625301, 6338.778142764981, 6340.334264902165, 6371.044343348489, 28181.0, 29557.26106847346, 30061.098167055025, 30437.847810760806, 30548.0, 2115.153938424627, 2118.046878904484, 2131.2753663754243, 2135.562209746998, 2139.828813694901, 18223.63552728938, 18636.16137273826, 18667.62664746711, 18688.0, 18731.62536749271, 2418.1657328221736, 2489.65144879717, 2508.686414198225, 2525.6211568264907, 2528.3047162030407, 137782.0, 144028.0, 146708.0, 151574.24212879085, 151627.0, 16072.196390180445, 16077.758833617505, 16215.513534593982, 16639.0, 16964.575885602713, 26429.603555946676, 26458.735412645627, 26484.867575662385, 26591.33521661935, 26758.866205669237, 11265.605703800327, 11321.094312454983, 11496.137789665809, 11534.307941523535, 11830.822537661941, 10580.36517808934, 10602.416867072385, 10690.412027338416, 10734.838977415346, 10802.72993175177, 9730.0, 9836.557354919047, 9943.254255930835, 9998.200143988464, 10249.231307651957, 2950.173951293641, 2997.730204281625, 3023.289526961162, 3036.3927214557175, 3079.337942342407, 1038.076112260089, 1054.0882136951634, 1061.8354155105972, 1062.9574817007233, 1084.0352086642895, 21105.68341474879, 21844.017019234172, 21925.561488770134, 22054.669179962315, 22054.669179962315, 1112.1992165640727, 1121.3776354123377, 1121.5401685308984, 1125.1954852280658, 1129.5989923577013, 11520.366379849189, 11761.235519691192, 11844.763104737856, 11950.223235489666, 12113.939430302793, 584375.0, 589214.0, 591253.0, 636811.0, 650881.0, 127426.0, 129641.0, 131512.3424382872, 133338.0, 133483.0, 1140.4411838199223, 1195.1813008089487, 1225.2709637765515, 1242.8135779632946, 1277.7763891318982, 22131.225407110673, 22565.548689026455, 22572.0, 22634.207802726825, 22656.433589160402, 65570.34429655642, 66302.0, 67054.66472667606, 67449.66275168593, 68596.0, 84296.57851710702, 84847.57576212079, 84935.0, 85141.57429212815, 86301.56849215714, 15815.209239538208, 16158.192090395669, 16281.0, 16284.592885177964, 16286.67426651484, 24334.51330973406, 24815.379615509755, 24974.62538061967, 25197.0, 25218.495630087662, 19825.20699172017, 20088.497787554843, 20108.798912010694, 20125.79874201298, 20131.39605811828, 16994.74507882358, 17499.30002799874, 17779.19993600317, 17869.195886184894, 18096.0, 20131.39605811828, 20262.18951241934, 20588.970551472667, 20766.896165519076, 20797.37607871766, 15916.681666366376, 16059.0, 16060.277287521856, 16063.0, 16070.598235044217, 20070.39788806338, 20227.898860505604, 20280.188792448138, 20423.38729838048, 20436.080376383397], "value": 13020.128997361773, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1430.9212993285369, 1522.9263369324635, 1529.2048134969816, 1531.3950989359203, 1535.9616009599752, 17008.57478563035, 17501.3874514392, 17638.647227055484, 17657.558561035963, 17661.646767064653, 17348.82651173488, 17487.825121748778, 17543.82456175438, 17549.29802807886, 17565.385211517598, 2793.888244470219, 2841.318083659922, 2911.8980835670754, 2912.490314195018, 2914.1257622713206, 2863.856807159644, 2912.8397938113394, 2914.227729651644, 2916.5916771651987, 2931.3551018775943, 2803.8457884816326, 2928.238657948938, 2947.484190266695, 2955.3055032067446, 2971.851407429631, 2849.772018238536, 2860.556613724855, 2870.2250392393935, 2873.6063009440404, 2889.8699558519916, 2631.9603756516262, 2647.1264482720658, 2675.103840213531, 2676.317539027555, 2683.4633073385207, 16955.237014334383, 17335.306587736475, 17357.913210433868, 17360.39238626642, 17369.2183851727, 8489.787755306104, 8731.214190722802, 8745.169208925143, 8748.125187481264, 8749.212570868589, 5183.974080129575, 5226.451222621646, 5238.13570760824, 5321.866953326159, 5336.759845806948, 1911.7132430135591, 1972.9013549322476, 1986.294865322804, 2005.6189324028387, 2008.2770202727006, 31380.529292060408, 31397.686023139704, 31539.684603153903, 31677.20806979821, 31701.682983170103, 7072.575645461289, 7096.680649370791, 7110.57336559808, 7189.712411503481, 7232.0598322217775, 20708.79291207099, 20838.1664733412, 20839.79160208409, 20876.58246835055, 20934.58130837375, 7982.121966583672, 8209.302209312274, 8210.548419836847, 8229.25936665703, 8241.670333186605, 7476.289752473506, 7490.775276741707, 7520.097588289331, 7648.541087534654, 7680.692772289158, 5867.20792692981, 6018.21763170785, 6053.697315134225, 6095.116208149793, 6303.9684801575695, 1583.7228485015075, 1605.414023881275, 1624.6507000994607, 1642.0640235065898, 1660.5848537865534, 1024.4928760263717, 1024.8667673202435, 1035.2649618770606, 1042.2339580408393, 1051.4637534857277, 9842.75393115178, 10372.325798823053, 10465.9476702616, 10475.214358923111, 10652.041316281571, 1092.1372116028408, 1102.311055590256, 1113.1595645287919, 1120.2438354110943, 1126.9267497612793, 5312.096943519611, 5388.191771234347, 5455.936092462011, 5465.480779325958, 5468.28912241414, 25474.23577292684, 26054.609180862302, 26409.603855942176, 26472.60291095635, 26859.462810743677, 26203.868980654974, 26418.207453776417, 26681.46637067248, 26790.196294111207, 26895.462090758076, 11205.60780372683, 11614.941925290319, 11943.104267179997, 12039.819402708967, 12049.277043377426, 9751.414915105117, 9842.09658150833, 9956.303058785816, 10008.599656013677, 10028.047335503115, 21417.357479275648, 21426.250081247083, 22217.00023498914, 22264.22075227359, 22631.434214144778, 22529.66205506886, 23140.884295578413, 23486.765132348457, 23503.0, 23828.404289892893, 12831.615051548468, 13009.0, 13053.086283960032, 13053.216806991612, 13057.608271751862, 16016.119113448873, 16132.919335403249, 16175.676486469969, 16229.350825966829, 16244.187790610185, 11962.222455540363, 12147.514099435924, 12182.086343524448, 12228.44971976281, 12463.626091217278, 11860.94069529647, 11988.700282493008, 12122.09084318662, 12259.632211033684, 12405.0, 11516.596919107791, 11571.190016699087, 11571.479283432434, 11746.353950532803, 11755.588554400554, 8247.505149691038, 8285.254327110348, 8309.584520773817, 8392.790180245544, 8490.872636910575, 8403.873941890753, 8409.159084091541, 8450.704225352083, 8453.915460845314, 8505.532195729294], "value": 7462.4712433168725, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [559.8096647139971, 576.3314555116066, 582.8717682109935, 598.3896425645842, 600.6396162302619, 6191.690415479231, 6273.717682704278, 6336.619802811829, 6361.650109243989, 6383.340161681975, 6294.937050629493, 6300.684965751706, 6309.810705678826, 6327.145835312232, 6333.271673757519, 5278.551323137519, 5282.815101471449, 5302.655327403726, 5310.8141215057485, 5313.840584782443, 4965.875853103666, 5040.5967522598285, 5087.084324821531, 5089.745512724349, 5227.398849132342, 5020.573251273646, 5067.29057931888, 5101.872453188681, 5105.030044291572, 5109.233614957768, 5040.949590504085, 5063.544281014708, 5071.8985620287385, 5082.2122571001555, 5084.51697088776, 4654.976725116387, 4658.301254811805, 4663.953360466386, 4669.182892993713, 4673.392458980345, 6261.342559031282, 6262.6868656566985, 6317.273513545955, 6332.588381755171, 6342.0, 5845.795397161079, 5892.23400957877, 5956.277326670831, 5957.165996760414, 5983.970080149571, 6662.300458451889, 6718.137071184089, 6729.798106056777, 6732.798016059526, 6766.8308292292595, 4999.8250061248045, 5118.948810511884, 5132.204508301219, 5151.124308867464, 5158.380994280673, 6801.897971530381, 6870.0, 6879.5184337095925, 6932.0, 6970.233274339818, 5281.9207711884355, 5289.338832645919, 5293.708846013429, 5315.574754019669, 5326.387465441524, 5309.601779866525, 5317.308749862493, 5353.892922141613, 5369.946300537023, 5382.515573598395, 5918.496927761103, 5931.406859314034, 5969.313528944227, 5976.5218782497295, 5993.220881285405, 6733.8989915151315, 6759.898601520981, 6764.526483146231, 6772.627505487246, 6789.1174147360525, 1816.2281030561958, 1822.1253798176683, 1823.1340113446006, 1834.3763120539081, 1857.535616095976, 1233.9321337326533, 1237.7833879071127, 1264.5321231144535, 1271.3007845685022, 1290.9225446473242, 6339.5562310637815, 6395.529028323419, 6416.358364163546, 6430.164078669836, 6485.513586480938, 6705.664716764142, 6799.422049125879, 6806.319368063154, 6806.5235433520165, 6814.557053791487, 6017.615948331821, 6259.843503912348, 6305.684715764193, 6307.6346370111205, 6405.551611387252, 3538.6815186633326, 3559.252556963015, 3560.768550044239, 3592.191756854687, 3595.856165753393, 6940.479464040116, 6984.755533556403, 7017.3684368407085, 7080.2919708028785, 7116.573005619576, 6900.482463815234, 6941.965290173517, 6953.756618518328, 6954.513184077167, 6994.720211191496, 7000.369966703021, 7032.824179395454, 7102.715891364391, 7107.857842843114, 7123.180834203926, 6650.667466626553, 6683.799486015428, 6689.0902457431175, 6729.360710732472, 6774.593524388552, 6672.232693240146, 6740.898886516608, 6750.966245168939, 6771.492138089761, 6804.4556435484055, 7090.574565526085, 7136.571805691675, 7155.248698886542, 7197.172325182671, 7238.203797582367, 5184.0927837629015, 5189.844304670866, 5202.115640341075, 5202.817901373585, 5229.738513074407, 6661.967395053774, 6807.0, 6807.591544507345, 6809.250982392032, 6916.135483064617, 6400.0, 6565.310642382672, 6611.900821487778, 6655.500837437308, 6666.733330666719, 6546.639934803631, 6551.901721474086, 6602.570832895846, 6603.438707709898, 6618.749625127287, 6417.582857114273, 6440.42036216724, 6465.870682586228, 6529.747237203157, 6613.0, 6682.231543372574, 6689.431398331197, 6691.899621505584, 6715.4627629790475, 6720.596764194164, 6365.40864783804, 6438.195225596801, 6457.321981191907, 6465.870682586416, 6572.474202063728], "value": 5246.5224520255515, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [985.7979114281572, 989.0752146742793, 1015.8425444056164, 1016.0652199976022, 1023.8054769593774, 17951.640967180665, 18056.819431805678, 18214.90892545537, 21119.894400528014, 21483.892580537115, 19327.90336048318, 19485.70771438426, 19502.414927552196, 20805.375838724864, 21013.68479472809, 1094.1520321750627, 1114.799336119498, 1116.3023110555903, 1120.7422292872643, 1123.2698745815203, 1076.252004856625, 1108.528875228029, 1115.893990070942, 1123.2867129372826, 1127.408110741863, 1166.9883301167008, 1171.77736230116, 1172.349346112907, 1172.5368479450653, 1172.724409763705, 1172.349346112907, 1174.6241202815102, 1174.6358628825092, 1174.7356844709914, 1177.658479041077, 861.7285555050139, 862.9007664118644, 863.2834747159842, 863.4517081653132, 864.7492227254089, 19667.311644092388, 19935.0, 20017.599648007104, 20030.69953950692, 20073.297434589866, 16934.06862622555, 17158.22787974532, 17177.055261960588, 17179.484615461555, 17186.140692965426, 17671.469855904343, 18297.908510457495, 18360.0, 18441.446756597325, 18470.261189552537, 3994.960050399517, 4014.578469260715, 4029.7783621900785, 4031.4154447605224, 4032.5765794591734, 152600.2369988154, 154570.0, 155342.0, 155548.22225888798, 158416.0, 15942.28259728315, 16002.839971600368, 16118.194090295437, 16124.193790310437, 16213.675726485404, 24958.376040598767, 29699.554506682416, 30370.0, 30370.240743981576, 30465.0, 9168.81662366749, 9333.719988400358, 9336.299777516713, 9373.1564159226, 9385.436873787457, 4199.811008504625, 4234.13200293939, 4244.1723863846255, 4254.276772948606, 4276.87169384919, 5800.738966746507, 5916.704164791743, 5917.378675239038, 5957.672328022, 5990.28116625999, 1154.9720748533812, 1187.602153278644, 1189.1556994533805, 1198.1553005131361, 1200.4297958469658, 705.7424040225384, 716.183550752143, 728.7631519756101, 735.7351353512731, 742.2466196810242, 12393.504259829686, 13030.739385212242, 13387.531436399679, 14046.1572305662, 14158.575242742734, 767.1982777997007, 771.691323470605, 779.5517577393022, 789.7314912929517, 794.1304271822345, 6518.706658200393, 6663.4669226461765, 6702.296258892844, 6770.119884414995, 6787.762428314985, 150301.0, 151962.0, 153612.0, 155082.22458887633, 156040.0, 134120.0, 135187.0, 136240.0, 136393.0, 139882.0, 119858.4007079959, 120137.39931300287, 120434.39782801205, 120574.39712801379, 122777.38611306886, 12665.683357916127, 12832.422540985492, 12851.228926264454, 12873.163244389085, 12963.101788686314, 57141.0, 57764.4223557759, 58160.70919645544, 58484.4151558479, 59507.70246148915, 71622.0, 72829.0, 73056.63471682607, 74213.0, 75700.62149689216, 16348.182590870647, 16778.664426711643, 17169.399071032454, 17275.65448690994, 17528.561785954942, 19693.0, 19747.506312342306, 20036.198552057755, 20113.6982945253, 20298.188072476936, 16980.0, 17026.489205323862, 17027.063511506985, 17186.570335741206, 17316.39392621252, 16374.099424531765, 16448.506544803677, 16449.25978330954, 16503.91748041252, 16616.58458538498, 20337.49156271105, 20621.79378206259, 20801.1679532817, 20855.8957205213, 20939.685904711136, 13536.390862411412, 13606.93196534011, 13657.863421365659, 13677.179369237878, 13743.175409475463, 15202.923985380003, 15384.615384615474, 15443.459478918634, 15616.063036217864, 15644.217789110726], "value": 9959.022986341937, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1368.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 107.0, 106.0, 105.0, 107.0, 106.0, 107.0, 105.0, 107.0, 106.0], "value": 106.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 110.0, 122.0, 109.0, 110.0, 110.0, 112.0, 139.0, 110.0, 111.0], "value": 114.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 162.0, 160.0, 163.0, 163.0, 163.0, 161.0, 162.0, 161.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 81.0, 73.0, 75.0, 74.0, 76.0, 73.0, 74.0, 74.0, 75.0], "value": 75.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 76.0, 81.0, 76.0, 77.0, 76.0, 78.0, 77.0, 77.0], "value": 77.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 113.0, 113.0, 114.0, 114.0, 116.0, 114.0], "value": 114.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 148.0, 148.0, 149.0, 149.0, 148.0, 148.0, 148.0, 148.0], "value": 148.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 97.0, 96.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 45.0, 44.0, 43.0, 43.0, 42.0, 43.0, 42.0, 46.0, 44.0], "value": 44.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [46.0, 46.0, 45.0, 46.0, 45.0, 46.0, 46.0, 46.0, 45.0, 45.0], "value": 45.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 68.0, 71.0, 68.0, 70.0, 71.0, 68.0, 70.0, 75.0], "value": 70.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 105.0, 108.0, 109.0, 106.0, 104.0, 106.0, 106.0, 100.0, 108.0], "value": 105.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 155.0, 150.0, 147.0, 149.0, 155.0, 152.0, 154.0, 161.0, 146.0], "value": 152.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 62.0, 66.0, 61.0, 58.0, 58.0, 57.0, 60.0, 58.0, 59.0], "value": 59.9, "unit": "score"}]}]} 13:13:44 INFO - Return code: 0 13:13:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:13:44 INFO - # TBPL SUCCESS # 13:13:44 INFO - Running post-action listener: _package_coverage_data 13:13:44 INFO - Running post-action listener: _resource_record_post_action 13:13:44 INFO - [mozharness: 2017-09-27 20:13:44.785247Z] Finished run-tests step (success) 13:13:44 INFO - Running post-run listener: _resource_record_post_run 13:13:44 INFO - Total resource usage - Wall time: 1181s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289890304; Read time: 8; Write time: 133132 13:13:44 INFO - TinderboxPrint: CPU usage
13.0% 13:13:44 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 13:13:44 INFO - TinderboxPrint: I/O write bytes / time
289,890,304 / 133,132 13:13:44 INFO - TinderboxPrint: CPU idle
8,188.3 (86.9%) 13:13:44 INFO - TinderboxPrint: CPU user
1,178.6 (12.5%) 13:13:44 INFO - TinderboxPrint: Swap in / out
0 / 0 13:13:44 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 12435456; Read time: 0; Write time: 1876 13:13:44 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 13:13:44 INFO - run-tests - Wall time: 1167s; CPU: 13.0%; Read bytes: 4096; Write bytes: 277454848; Read time: 8; Write time: 131256 13:13:45 INFO - Running post-run listener: _upload_blobber_files 13:13:45 INFO - Blob upload gear active. 13:13:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:13:45 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 13:13:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:13:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:13:45 INFO - (blobuploader) - INFO - Open directory for files ... 13:13:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 13:13:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:13:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:13:46 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 13:13:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:13:46 INFO - (blobuploader) - INFO - Done attempting. 13:13:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:13:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:13:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:13:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:13:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:13:47 INFO - (blobuploader) - INFO - Done attempting. 13:13:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:13:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:13:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:13:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:13:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:13:51 INFO - (blobuploader) - INFO - Done attempting. 13:13:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:13:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:13:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:13:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:13:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:13:52 INFO - (blobuploader) - INFO - Done attempting. 13:13:52 INFO - (blobuploader) - INFO - Iteration through files over. 13:13:52 INFO - Return code: 0 13:13:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:13:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:13:52 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/57ac344fadbeda1d9cb3fbd07a52c05ee62a79a52c0ea9a41f5bce0500f6795d46f73668206541de366d030b37e0add90b0506c10754204e4d4b7aca1d82a9c5", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/85e894bf43c2e59f3fc76496e3f0dae4f68c008a15cb2322782d8eca3a110847700b598cb43876e609e44e1645b54d2fec4f05feefcf0bd578da0063e8ece233", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/19a5c9637014f13c342e66046af31d128af64c2b760a1b21d9bea01bec31d4b0ae8a995c0d225137ff163bfdca387247b5592e67c460270bee6eb1bd11083678", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/3a7999d3890f28ca4d9e051c772741bd9986eda894e66945f3e3e00b432bf58521d98c903a2d841567bd6d7a6e88d43a75e49dab14ff9da06a7dbcdbefc9849a"} 13:13:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:13:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:13:52 INFO - Contents: 13:13:52 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/57ac344fadbeda1d9cb3fbd07a52c05ee62a79a52c0ea9a41f5bce0500f6795d46f73668206541de366d030b37e0add90b0506c10754204e4d4b7aca1d82a9c5", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/85e894bf43c2e59f3fc76496e3f0dae4f68c008a15cb2322782d8eca3a110847700b598cb43876e609e44e1645b54d2fec4f05feefcf0bd578da0063e8ece233", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/19a5c9637014f13c342e66046af31d128af64c2b760a1b21d9bea01bec31d4b0ae8a995c0d225137ff163bfdca387247b5592e67c460270bee6eb1bd11083678", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/3a7999d3890f28ca4d9e051c772741bd9986eda894e66945f3e3e00b432bf58521d98c903a2d841567bd6d7a6e88d43a75e49dab14ff9da06a7dbcdbefc9849a"} 13:13:52 INFO - Running post-run listener: copy_logs_to_upload_dir 13:13:52 INFO - Copying logs to upload dir... 13:13:52 INFO - mkdir: /builds/slave/test/build/upload/logs 13:13:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1227.028654 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2017-09-27 13:13:52.025875) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-27 13:13:52.029955) ========= 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=d2a8c569965ab8367867b893000001a1-1506542003.74556-1805683729 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/57ac344fadbeda1d9cb3fbd07a52c05ee62a79a52c0ea9a41f5bce0500f6795d46f73668206541de366d030b37e0add90b0506c10754204e4d4b7aca1d82a9c5", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/85e894bf43c2e59f3fc76496e3f0dae4f68c008a15cb2322782d8eca3a110847700b598cb43876e609e44e1645b54d2fec4f05feefcf0bd578da0063e8ece233", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/19a5c9637014f13c342e66046af31d128af64c2b760a1b21d9bea01bec31d4b0ae8a995c0d225137ff163bfdca387247b5592e67c460270bee6eb1bd11083678", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/3a7999d3890f28ca4d9e051c772741bd9986eda894e66945f3e3e00b432bf58521d98c903a2d841567bd6d7a6e88d43a75e49dab14ff9da06a7dbcdbefc9849a"} build_url:https://queue.taskcluster.net/v1/task/ADu_DyoQRUasrawy0ZNw_A/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011448 build_url: 'https://queue.taskcluster.net/v1/task/ADu_DyoQRUasrawy0ZNw_A/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/57ac344fadbeda1d9cb3fbd07a52c05ee62a79a52c0ea9a41f5bce0500f6795d46f73668206541de366d030b37e0add90b0506c10754204e4d4b7aca1d82a9c5", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/85e894bf43c2e59f3fc76496e3f0dae4f68c008a15cb2322782d8eca3a110847700b598cb43876e609e44e1645b54d2fec4f05feefcf0bd578da0063e8ece233", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/19a5c9637014f13c342e66046af31d128af64c2b760a1b21d9bea01bec31d4b0ae8a995c0d225137ff163bfdca387247b5592e67c460270bee6eb1bd11083678", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/3a7999d3890f28ca4d9e051c772741bd9986eda894e66945f3e3e00b432bf58521d98c903a2d841567bd6d7a6e88d43a75e49dab14ff9da06a7dbcdbefc9849a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-27 13:13:52.058485) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 13:13:52.058812) ========= 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=d2a8c569965ab8367867b893000001a1-1506542003.74556-1805683729 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004486 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 13:13:52.141499) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-27 13:13:52.141808) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-27 13:13:52.142116) ========= ========= Total master_lag: 0.19 =========