builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-043 starttime: 1506351818.1 results: success (0) revision: 8158695b90e423f6eb559ac90ee967f196afd44f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-25 08:03:38.100983) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-25 08:03:38.101444) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-25 08:03:38.101803) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-25 08:03:38.137469) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 08:03:38.138061) ========= 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-1506351790.807965-1201926482 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-25 08:03:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 221M=0s 2017-09-25 08:03:38 (221 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.163391 ========= master_lag: 0.42 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 08:03:38.725742) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 08:03:38.729155) ========= 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-1506351790.807965-1201926482 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016852 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 08:03:38.778834) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-25 08:03:38.779236) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 8158695b90e423f6eb559ac90ee967f196afd44f --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 8158695b90e423f6eb559ac90ee967f196afd44f --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-1506351790.807965-1201926482 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-25 08:03:38,854 truncating revision to first 12 chars 2017-09-25 08:03:38,854 Setting DEBUG logging. 2017-09-25 08:03:38,854 attempt 1/10 2017-09-25 08:03:38,854 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/8158695b90e4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-25 08:03:40,345 unpacking tar archive at: mozilla-beta-8158695b90e4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.776839 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-25 08:03:40.575504) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-25 08:03:40.575824) ========= script_repo_revision: 8158695b90e423f6eb559ac90ee967f196afd44f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-25 08:03:40.576207) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-25 08:03:40.576477) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-25 08:03:40.590346) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2017-09-25 08:03:40.590727) ========= /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-1506351790.807965-1201926482 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:03:40 INFO - MultiFileLogger online at 20170925 08:03:40 in /builds/slave/test 08:03:40 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 08:03:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:03:40 INFO - {'append_to_log': False, 08:03:40 INFO - 'base_work_dir': '/builds/slave/test', 08:03:40 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 08:03:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:03:40 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 08:03:40 INFO - 'buildbot_json_path': 'buildprops.json', 08:03:40 INFO - 'code_coverage': False, 08:03:40 INFO - 'config_files': ('talos/linux_config.py',), 08:03:40 INFO - 'default_actions': ('clobber', 08:03:40 INFO - 'read-buildbot-config', 08:03:40 INFO - 'download-and-extract', 08:03:40 INFO - 'populate-webroot', 08:03:40 INFO - 'create-virtualenv', 08:03:40 INFO - 'install', 08:03:40 INFO - 'setup-mitmproxy', 08:03:40 INFO - 'run-tests'), 08:03:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:03:40 INFO - 'disable_ccov_upload': False, 08:03:40 INFO - 'disable_stylo': False, 08:03:40 INFO - 'download_minidump_stackwalk': True, 08:03:40 INFO - 'download_symbols': 'ondemand', 08:03:40 INFO - 'enable_stylo': False, 08:03:40 INFO - 'enable_webrender': False, 08:03:40 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 08:03:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:03:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:03:40 INFO - 'gecko_profile': False, 08:03:40 INFO - 'gecko_profile_interval': 0, 08:03:40 INFO - 'installer_path': 'installer.exe', 08:03:40 INFO - 'log_level': 'info', 08:03:40 INFO - 'log_name': 'talos', 08:03:40 INFO - 'log_to_console': True, 08:03:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:03:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:03:40 INFO - 'opt_config_files': (), 08:03:40 INFO - 'pip_index': False, 08:03:40 INFO - 'suite': 'dromaeojs-e10s', 08:03:40 INFO - 'system_bits': '32', 08:03:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:03:40 INFO - 'title': 'talos-linux64-ix-043', 08:03:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:03:40 INFO - 'use_talos_json': True, 08:03:40 INFO - 'verify': 'False', 08:03:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:03:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:03:40 INFO - 'work_dir': 'build'} 08:03:40 INFO - [mozharness: 2017-09-25 15:03:40.802836Z] Running clobber step. 08:03:40 INFO - Running pre-action listener: _resource_record_pre_action 08:03:40 INFO - Running main action method: clobber 08:03:40 INFO - rmtree: /builds/slave/test/build 08:03:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:03:41 INFO - Running post-action listener: _resource_record_post_action 08:03:41 INFO - [mozharness: 2017-09-25 15:03:41.801215Z] Finished clobber step (success) 08:03:41 INFO - [mozharness: 2017-09-25 15:03:41.801312Z] Running read-buildbot-config step. 08:03:41 INFO - Running pre-action listener: _resource_record_pre_action 08:03:41 INFO - Running main action method: read_buildbot_config 08:03:41 INFO - Using buildbot properties: 08:03:41 INFO - { 08:03:41 INFO - "project": "", 08:03:41 INFO - "product": "firefox", 08:03:41 INFO - "who": "ryanvm@gmail.com", 08:03:41 INFO - "installer_path": "public/build/target.tar.bz2", 08:03:41 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 08:03:41 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 08:03:41 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs-e10s", 08:03:41 INFO - "stage_platform": "linux64", 08:03:41 INFO - "basedir": "/builds/slave/test", 08:03:41 INFO - "buildnumber": 116, 08:03:41 INFO - "platform": "ubuntu64_hw", 08:03:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:03:41 INFO - "slavebuilddir": "test", 08:03:41 INFO - "taskId": "Ct8uA6lzQsaXPyToRk1vsQ", 08:03:41 INFO - "branch": "mozilla-beta", 08:03:41 INFO - "script_repo_revision": "production", 08:03:41 INFO - "revision": "8158695b90e423f6eb559ac90ee967f196afd44f", 08:03:41 INFO - "slavename": "talos-linux64-ix-043", 08:03:41 INFO - "repo_path": "releases/mozilla-beta" 08:03:41 INFO - } 08:03:41 INFO - Finding installer, test and symbols from parent task. 08:03:41 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ct8uA6lzQsaXPyToRk1vsQ'}, attempt #1 08:03:42 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ct8uA6lzQsaXPyToRk1vsQ'}, attempt #1 08:03:42 INFO - Task dependencies: XNXT-O_xRDSxhs9chRjF3Q 08:03:42 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XNXT-O_xRDSxhs9chRjF3Q'}, attempt #1 08:03:43 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/XNXT-O_xRDSxhs9chRjF3Q/artifacts/public/build/target.tar.bz2 08:03:43 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/XNXT-O_xRDSxhs9chRjF3Q/artifacts/public/build/target.test_packages.json 08:03:43 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/XNXT-O_xRDSxhs9chRjF3Q/artifacts/public/build/target.crashreporter-symbols.zip 08:03:43 INFO - Running post-action listener: _resource_record_post_action 08:03:43 INFO - [mozharness: 2017-09-25 15:03:43.301241Z] Finished read-buildbot-config step (success) 08:03:43 INFO - [mozharness: 2017-09-25 15:03:43.301552Z] Running download-and-extract step. 08:03:43 INFO - Running pre-action listener: _resource_record_pre_action 08:03:43 INFO - Running main action method: download_and_extract 08:03:43 INFO - mkdir: /builds/slave/test/build/tests 08:03:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:03:43 INFO - trying https://queue.taskcluster.net/v1/task/XNXT-O_xRDSxhs9chRjF3Q/artifacts/public/build/target.test_packages.json 08:03:43 INFO - Downloading https://queue.taskcluster.net/v1/task/XNXT-O_xRDSxhs9chRjF3Q/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:03:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XNXT-O_xRDSxhs9chRjF3Q/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:03:43 INFO - Downloaded 989 bytes. 08:03:43 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:03:43 INFO - Using the following test package requirements: 08:03:43 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 08:03:43 INFO - u'common': [u'target.common.tests.zip'], 08:03:43 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:03:43 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:03:43 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:03:43 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:03:43 INFO - u'mozbase': [u'target.common.tests.zip'], 08:03:43 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:03:43 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:03:43 INFO - u'web-platform': [u'target.common.tests.zip', 08:03:43 INFO - u'target.web-platform.tests.tar.gz'], 08:03:43 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:03:43 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 08:03:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XNXT-O_xRDSxhs9chRjF3Q/artifacts/public/build/target.common.tests.zip 08:03:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XNXT-O_xRDSxhs9chRjF3Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:03:43 INFO - Fetch https://queue.taskcluster.net/v1/task/XNXT-O_xRDSxhs9chRjF3Q/artifacts/public/build/target.common.tests.zip into memory 08:03:45 INFO - Content-Length response header: 55172935 08:03:45 INFO - Bytes received: 55172935 08:03:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XNXT-O_xRDSxhs9chRjF3Q/artifacts/public/build/target.talos.tests.zip 08:03:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XNXT-O_xRDSxhs9chRjF3Q/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:03:55 INFO - Fetch https://queue.taskcluster.net/v1/task/XNXT-O_xRDSxhs9chRjF3Q/artifacts/public/build/target.talos.tests.zip into memory 08:03:56 INFO - Content-Length response header: 14509184 08:03:56 INFO - Bytes received: 14509184 08:03:56 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')]} 08:03:56 INFO - trying https://queue.taskcluster.net/v1/task/XNXT-O_xRDSxhs9chRjF3Q/artifacts/public/build/target.tar.bz2 08:03:56 INFO - Downloading https://queue.taskcluster.net/v1/task/XNXT-O_xRDSxhs9chRjF3Q/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:03:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XNXT-O_xRDSxhs9chRjF3Q/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:03:57 INFO - Downloaded 53522107 bytes. 08:03:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XNXT-O_xRDSxhs9chRjF3Q/artifacts/public/build/target.tar.bz2 08:03:57 INFO - mkdir: /builds/slave/test/properties 08:03:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:03:57 INFO - Writing to file /builds/slave/test/properties/build_url 08:03:57 INFO - Contents: 08:03:57 INFO - build_url:https://queue.taskcluster.net/v1/task/XNXT-O_xRDSxhs9chRjF3Q/artifacts/public/build/target.tar.bz2 08:03:57 INFO - Running post-action listener: _resource_record_post_action 08:03:57 INFO - Running post-action listener: find_tests_for_verification 08:03:57 INFO - Running post-action listener: set_extra_try_arguments 08:03:57 INFO - [mozharness: 2017-09-25 15:03:57.686600Z] Finished download-and-extract step (success) 08:03:57 INFO - [mozharness: 2017-09-25 15:03:57.686699Z] Running populate-webroot step. 08:03:57 INFO - Running pre-action listener: _resource_record_pre_action 08:03:57 INFO - Running main action method: populate_webroot 08:03:57 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:03:57 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:03:57 INFO - 'tests': ['tresize', 08:03:57 INFO - 'tcanvasmark']}, 08:03:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:03:57 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:03:57 INFO - 'tests': ['dromaeo_css', 08:03:57 INFO - 'kraken']}, 08:03:57 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:03:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:03:57 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 08:03:57 INFO - 'talos_options': ['--disable-stylo'], 08:03:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:03:57 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:03:57 INFO - 'tests': ['damp', 'tps']}, 08:03:57 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 08:03:57 INFO - 'talos_options': ['--disable-stylo'], 08:03:57 INFO - 'tests': ['damp', 'tps']}, 08:03:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:03:57 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:03:57 INFO - 'tests': ['dromaeo_dom']}, 08:03:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 08:03:57 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:03:57 INFO - 'tests': ['basic_compositor_video', 08:03:57 INFO - 'glvideo']}, 08:03:57 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 08:03:57 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 08:03:57 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 08:03:57 INFO - 'talos_options': ['--disable-stylo'], 08:03:57 INFO - 'tests': ['ts_paint_webext', 08:03:57 INFO - 'tp5o_webext']}, 08:03:57 INFO - 'other-e10s': {'tests': ['a11yr', 08:03:57 INFO - 'ts_paint', 08:03:57 INFO - 'tpaint', 08:03:57 INFO - 'sessionrestore', 08:03:57 INFO - 'sessionrestore_many_windows', 08:03:57 INFO - 'sessionrestore_no_auto_restore', 08:03:57 INFO - 'tabpaint']}, 08:03:57 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:03:57 INFO - 'tests': ['a11yr', 08:03:57 INFO - 'ts_paint', 08:03:57 INFO - 'tpaint', 08:03:57 INFO - 'sessionrestore', 08:03:57 INFO - 'sessionrestore_many_windows', 08:03:57 INFO - 'sessionrestore_no_auto_restore', 08:03:57 INFO - 'tabpaint']}, 08:03:57 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 08:03:57 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 08:03:57 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:03:57 INFO - 'tests': ['perf_reftest_singletons']}, 08:03:57 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:03:57 INFO - 'tests': ['bloom_basic']}, 08:03:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:03:57 INFO - 'tsvgr_opacity', 08:03:57 INFO - 'tart', 08:03:57 INFO - 'tscrollx', 08:03:57 INFO - 'tsvg_static']}, 08:03:57 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:03:57 INFO - 'tests': ['tsvgx', 08:03:57 INFO - 'tsvgr_opacity', 08:03:57 INFO - 'tart', 08:03:57 INFO - 'tscrollx', 08:03:57 INFO - 'tsvg_static']}, 08:03:57 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:03:57 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 08:03:57 INFO - 'talos_options': ['--disable-stylo'], 08:03:57 INFO - 'tests': ['tp5o']}, 08:03:57 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 08:03:57 INFO - 'talos_options': ['--mitmproxy', 08:03:57 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 08:03:57 INFO - '--firstNonBlankPaint'], 08:03:57 INFO - 'tests': ['tp6_google', 08:03:57 INFO - 'tp6_youtube', 08:03:57 INFO - 'tp6_amazon', 08:03:57 INFO - 'tp6_facebook']}, 08:03:57 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 08:03:57 INFO - 'talos_options': ['--disable-stylo', 08:03:57 INFO - '--mitmproxy', 08:03:57 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 08:03:57 INFO - '--firstNonBlankPaint'], 08:03:57 INFO - 'tests': ['tp6_google', 08:03:57 INFO - 'tp6_youtube', 08:03:57 INFO - 'tp6_amazon', 08:03:57 INFO - 'tp6_facebook']}, 08:03:57 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 08:03:57 INFO - 'talos_options': ['--stylo-threads=1', 08:03:57 INFO - '--mitmproxy', 08:03:57 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 08:03:57 INFO - '--firstNonBlankPaint'], 08:03:57 INFO - 'tests': ['tp6_google', 08:03:57 INFO - 'tp6_youtube', 08:03:57 INFO - 'tp6_amazon', 08:03:57 INFO - 'tp6_facebook']}, 08:03:57 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:03:57 INFO - 'talos_options': ['--xperf_path', 08:03:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:03:57 INFO - 'tests': ['tp5n']}, 08:03:57 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 08:03:57 INFO - 'talos_options': ['--disable-stylo', 08:03:57 INFO - '--xperf_path', 08:03:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:03:57 INFO - 'tests': ['tp5n']}}} 08:03:57 INFO - Running post-action listener: _resource_record_post_action 08:03:57 INFO - [mozharness: 2017-09-25 15:03:57.701758Z] Finished populate-webroot step (success) 08:03:57 INFO - [mozharness: 2017-09-25 15:03:57.701858Z] Running create-virtualenv step. 08:03:57 INFO - Running pre-action listener: _resource_record_pre_action 08:03:57 INFO - Running main action method: create_virtualenv 08:03:57 INFO - Creating virtualenv /builds/slave/test/build/venv 08:03:57 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:03:57 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 08:03:57 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 08:03:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:03:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:03:58 INFO - Installing distribute.............................................................................................................................................................................................done. 08:03:58 INFO - Installing pip...............done. 08:03:58 INFO - Return code: 0 08:03:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:03:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:03:58 INFO - Reading from file tmpfile_stdout 08:03:58 INFO - Output received: 08:03:58 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 08:03:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:03:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:03:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:03:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:03:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:03:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1440a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1444090>, '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 0x1444d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x143ef90>, '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-1506351790.807965-1201926482', '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 08:03:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:03:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:03:58 INFO - Using env: {'DISPLAY': ':0', 08:03:58 INFO - 'HOME': '/home/cltbld', 08:03:58 INFO - 'LANG': 'en_US.UTF-8', 08:03:58 INFO - 'LANGUAGE': 'en_US:en', 08:03:58 INFO - 'LOGNAME': 'cltbld', 08:03:58 INFO - 'MAIL': '/var/mail/cltbld', 08:03:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:03:58 INFO - 'MOZ_NO_REMOTE': '1', 08:03:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:03:58 INFO - 'NO_EM_RESTART': '1', 08:03:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:03:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:03:58 INFO - 'PWD': '/builds/slave/test', 08:03:58 INFO - 'SHELL': '/bin/bash', 08:03:58 INFO - 'SHLVL': '1', 08:03:58 INFO - 'TERM': 'linux', 08:03:58 INFO - 'TMOUT': '86400', 08:03:58 INFO - 'USER': 'cltbld', 08:03:58 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1506351790.807965-1201926482', 08:03:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:03:58 INFO - '_': '/tools/buildbot/bin/python'} 08:04:00 INFO - Ignoring indexes: http://pypi.python.org/simple/ 08:04:00 INFO - Downloading/unpacking pip>=1.5 08:04:00 INFO - Running setup.py egg_info for package pip 08:04:00 INFO - warning: no files found matching 'pip/cacert.pem' 08:04:00 INFO - warning: no files found matching '*.html' under directory 'docs' 08:04:00 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 08:04:00 INFO - no previously-included directories found matching 'docs/_build/_sources' 08:04:00 INFO - Installing collected packages: pip 08:04:00 INFO - Found existing installation: pip 1.1 08:04:00 INFO - Uninstalling pip: 08:04:00 INFO - Successfully uninstalled pip 08:04:00 INFO - Running setup.py install for pip 08:04:00 INFO - warning: no files found matching 'pip/cacert.pem' 08:04:00 INFO - warning: no files found matching '*.html' under directory 'docs' 08:04:00 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 08:04:00 INFO - no previously-included directories found matching 'docs/_build/_sources' 08:04:00 INFO - Installing pip script to /builds/slave/test/build/venv/bin 08:04:00 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 08:04:00 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 08:04:00 INFO - Successfully installed pip 08:04:00 INFO - Cleaning up... 08:04:00 INFO - Return code: 0 08:04:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:04: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')]} 08:04:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04: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')]} 08:04:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1440a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1444090>, '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 0x1444d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x143ef90>, '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-1506351790.807965-1201926482', '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 08:04:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:04:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:04:00 INFO - Using env: {'DISPLAY': ':0', 08:04:00 INFO - 'HOME': '/home/cltbld', 08:04:00 INFO - 'LANG': 'en_US.UTF-8', 08:04:00 INFO - 'LANGUAGE': 'en_US:en', 08:04:00 INFO - 'LOGNAME': 'cltbld', 08:04:00 INFO - 'MAIL': '/var/mail/cltbld', 08:04:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:00 INFO - 'MOZ_NO_REMOTE': '1', 08:04:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:00 INFO - 'NO_EM_RESTART': '1', 08:04:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:00 INFO - 'PWD': '/builds/slave/test', 08:04:00 INFO - 'SHELL': '/bin/bash', 08:04:00 INFO - 'SHLVL': '1', 08:04:00 INFO - 'TERM': 'linux', 08:04:00 INFO - 'TMOUT': '86400', 08:04:00 INFO - 'USER': 'cltbld', 08:04:00 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1506351790.807965-1201926482', 08:04:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:00 INFO - '_': '/tools/buildbot/bin/python'} 08:04:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:00 INFO - Downloading/unpacking psutil>=3.1.1 08:04: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 08:04: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 08:04: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 08:04: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 08:04:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:04:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:04:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:04:01 INFO - Installing collected packages: psutil 08:04:01 INFO - Running setup.py install for psutil 08:04:01 INFO - building 'psutil._psutil_linux' extension 08:04:01 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 08:04:01 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 08:04:01 INFO - building 'psutil._psutil_posix' extension 08:04:01 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 08:04:02 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:04:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:04:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:04:02 INFO - Successfully installed psutil 08:04:02 INFO - Cleaning up... 08:04:02 INFO - Return code: 0 08:04:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:04: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')]} 08:04:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04: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')]} 08:04:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1440a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1444090>, '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 0x1444d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x143ef90>, '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-1506351790.807965-1201926482', '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 08:04:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:04:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:04:02 INFO - Using env: {'DISPLAY': ':0', 08:04:02 INFO - 'HOME': '/home/cltbld', 08:04:02 INFO - 'LANG': 'en_US.UTF-8', 08:04:02 INFO - 'LANGUAGE': 'en_US:en', 08:04:02 INFO - 'LOGNAME': 'cltbld', 08:04:02 INFO - 'MAIL': '/var/mail/cltbld', 08:04:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:02 INFO - 'MOZ_NO_REMOTE': '1', 08:04:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:02 INFO - 'NO_EM_RESTART': '1', 08:04:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:02 INFO - 'PWD': '/builds/slave/test', 08:04:02 INFO - 'SHELL': '/bin/bash', 08:04:02 INFO - 'SHLVL': '1', 08:04:02 INFO - 'TERM': 'linux', 08:04:02 INFO - 'TMOUT': '86400', 08:04:02 INFO - 'USER': 'cltbld', 08:04:02 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1506351790.807965-1201926482', 08:04:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:02 INFO - '_': '/tools/buildbot/bin/python'} 08:04:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:02 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:04:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:04:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:04:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:04:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:04:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:04:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:04:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:04:03 INFO - Installing collected packages: mozsystemmonitor 08:04:03 INFO - Running setup.py install for mozsystemmonitor 08:04:03 INFO - Successfully installed mozsystemmonitor 08:04:03 INFO - Cleaning up... 08:04:03 INFO - Return code: 0 08:04:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:04:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:04:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:04:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10d51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1440a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1444090>, '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 0x1444d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x143ef90>, '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-1506351790.807965-1201926482', '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 08:04:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:04:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:04:03 INFO - Using env: {'DISPLAY': ':0', 08:04:03 INFO - 'HOME': '/home/cltbld', 08:04:03 INFO - 'LANG': 'en_US.UTF-8', 08:04:03 INFO - 'LANGUAGE': 'en_US:en', 08:04:03 INFO - 'LOGNAME': 'cltbld', 08:04:03 INFO - 'MAIL': '/var/mail/cltbld', 08:04:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:03 INFO - 'MOZ_NO_REMOTE': '1', 08:04:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:03 INFO - 'NO_EM_RESTART': '1', 08:04:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:03 INFO - 'PWD': '/builds/slave/test', 08:04:03 INFO - 'SHELL': '/bin/bash', 08:04:03 INFO - 'SHLVL': '1', 08:04:03 INFO - 'TERM': 'linux', 08:04:03 INFO - 'TMOUT': '86400', 08:04:03 INFO - 'USER': 'cltbld', 08:04:03 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1506351790.807965-1201926482', 08:04:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:03 INFO - '_': '/tools/buildbot/bin/python'} 08:04:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:03 INFO - Downloading/unpacking jsonschema==2.5.1 08:04:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:04:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:04:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:04:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:04:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:04:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:04:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:04:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:04:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:04:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:04:05 INFO - Downloading functools32-3.2.3-2.tar.gz 08:04:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:04:05 INFO - warning: no files found matching '*.txt' 08:04:05 INFO - no previously-included directories found matching 'build' 08:04:05 INFO - no previously-included directories found matching 'dist' 08:04:05 INFO - no previously-included directories found matching '.git*' 08:04:05 INFO - Installing collected packages: jsonschema, functools32 08:04:05 INFO - Running setup.py install for functools32 08:04:05 INFO - warning: no files found matching '*.txt' 08:04:05 INFO - no previously-included directories found matching 'build' 08:04:05 INFO - no previously-included directories found matching 'dist' 08:04:05 INFO - no previously-included directories found matching '.git*' 08:04:05 INFO - Successfully installed jsonschema functools32 08:04:05 INFO - Cleaning up... 08:04:05 INFO - Return code: 0 08:04:05 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:04:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:04:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:04:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1440a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1444090>, '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 0x1444d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x143ef90>, '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-1506351790.807965-1201926482', '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 08:04:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:04:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:04:05 INFO - Using env: {'DISPLAY': ':0', 08:04:05 INFO - 'HOME': '/home/cltbld', 08:04:05 INFO - 'LANG': 'en_US.UTF-8', 08:04:05 INFO - 'LANGUAGE': 'en_US:en', 08:04:05 INFO - 'LOGNAME': 'cltbld', 08:04:05 INFO - 'MAIL': '/var/mail/cltbld', 08:04:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:05 INFO - 'MOZ_NO_REMOTE': '1', 08:04:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:05 INFO - 'NO_EM_RESTART': '1', 08:04:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:05 INFO - 'PWD': '/builds/slave/test', 08:04:05 INFO - 'SHELL': '/bin/bash', 08:04:05 INFO - 'SHLVL': '1', 08:04:05 INFO - 'TERM': 'linux', 08:04:05 INFO - 'TMOUT': '86400', 08:04:05 INFO - 'USER': 'cltbld', 08:04:05 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1506351790.807965-1201926482', 08:04:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:05 INFO - '_': '/tools/buildbot/bin/python'} 08:04:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:05 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:04:05 INFO - Cleaning up... 08:04:05 INFO - Return code: 0 08:04:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:04:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:04:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:04:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10d51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1440a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1444090>, '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 0x1444d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x143ef90>, '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-1506351790.807965-1201926482', '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 08:04:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:04:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:04:05 INFO - Using env: {'DISPLAY': ':0', 08:04:05 INFO - 'HOME': '/home/cltbld', 08:04:05 INFO - 'LANG': 'en_US.UTF-8', 08:04:05 INFO - 'LANGUAGE': 'en_US:en', 08:04:05 INFO - 'LOGNAME': 'cltbld', 08:04:05 INFO - 'MAIL': '/var/mail/cltbld', 08:04:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:05 INFO - 'MOZ_NO_REMOTE': '1', 08:04:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:05 INFO - 'NO_EM_RESTART': '1', 08:04:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:05 INFO - 'PWD': '/builds/slave/test', 08:04:05 INFO - 'SHELL': '/bin/bash', 08:04:05 INFO - 'SHLVL': '1', 08:04:05 INFO - 'TERM': 'linux', 08:04:05 INFO - 'TMOUT': '86400', 08:04:05 INFO - 'USER': 'cltbld', 08:04:05 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1506351790.807965-1201926482', 08:04:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:05 INFO - '_': '/tools/buildbot/bin/python'} 08:04:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:06 INFO - Downloading/unpacking blobuploader==1.2.4 08:04:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:04:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:04:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:04:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:04:07 INFO - Downloading blobuploader-1.2.4.tar.gz 08:04:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:04:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:04:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:04:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:04:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:04:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:04:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:04:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:04:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:04:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:04:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:04:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:04:08 INFO - Downloading docopt-0.6.1.tar.gz 08:04:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:04:08 INFO - Installing collected packages: blobuploader, requests, docopt 08:04:08 INFO - Running setup.py install for blobuploader 08:04:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:04:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:04:08 INFO - Running setup.py install for requests 08:04:08 INFO - Running setup.py install for docopt 08:04:09 INFO - Successfully installed blobuploader requests docopt 08:04:09 INFO - Cleaning up... 08:04:09 INFO - Return code: 0 08:04:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:04:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:04:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:04:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:09 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 0x10d51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1440a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1444090>, '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 0x1444d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x143ef90>, '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-1506351790.807965-1201926482', '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 08:04:09 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 08:04:09 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 08:04:09 INFO - Using env: {'DISPLAY': ':0', 08:04:09 INFO - 'HOME': '/home/cltbld', 08:04:09 INFO - 'LANG': 'en_US.UTF-8', 08:04:09 INFO - 'LANGUAGE': 'en_US:en', 08:04:09 INFO - 'LOGNAME': 'cltbld', 08:04:09 INFO - 'MAIL': '/var/mail/cltbld', 08:04:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:09 INFO - 'MOZ_NO_REMOTE': '1', 08:04:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:09 INFO - 'NO_EM_RESTART': '1', 08:04:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:09 INFO - 'PWD': '/builds/slave/test', 08:04:09 INFO - 'SHELL': '/bin/bash', 08:04:09 INFO - 'SHLVL': '1', 08:04:09 INFO - 'TERM': 'linux', 08:04:09 INFO - 'TMOUT': '86400', 08:04:09 INFO - 'USER': 'cltbld', 08:04:09 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1506351790.807965-1201926482', 08:04:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:09 INFO - '_': '/tools/buildbot/bin/python'} 08:04:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:04:09 INFO - Running setup.py (path:/tmp/pip-697k__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:04:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:04:09 INFO - Running setup.py (path:/tmp/pip-0lejId-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:04:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:04:09 INFO - Running setup.py (path:/tmp/pip-Btcc8P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:04:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:04:09 INFO - Running setup.py (path:/tmp/pip-7Z9Lsy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:04:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:04:09 INFO - Running setup.py (path:/tmp/pip-13Fp3E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:04:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:04:09 INFO - Running setup.py (path:/tmp/pip-kO5l2u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:04:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:04:09 INFO - Running setup.py (path:/tmp/pip-AGx6DH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:04:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:04:09 INFO - Running setup.py (path:/tmp/pip-xbAxQh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:04:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:04:09 INFO - Running setup.py (path:/tmp/pip-tpeckF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:04:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:04:10 INFO - Running setup.py (path:/tmp/pip-ai6o0y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:04:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:04:10 INFO - Running setup.py (path:/tmp/pip-BuMs03-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:04:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:04:10 INFO - Running setup.py (path:/tmp/pip-duYZoy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:04:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:04:10 INFO - Running setup.py (path:/tmp/pip-RslgAs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:04:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:04:10 INFO - Running setup.py (path:/tmp/pip-bzHYM8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:04:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:04:10 INFO - Running setup.py (path:/tmp/pip-qQEAQK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:04:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:04:10 INFO - Running setup.py (path:/tmp/pip-BtPURX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:04:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:04:10 INFO - Running setup.py (path:/tmp/pip-Et50df-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:04:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:04:10 INFO - Running setup.py install for manifestparser 08:04:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:04:10 INFO - Running setup.py install for mozcrash 08:04:10 INFO - Running setup.py install for mozdebug 08:04:10 INFO - Running setup.py install for mozdevice 08:04:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:04:10 INFO - Running setup.py install for mozfile 08:04:11 INFO - Running setup.py install for mozhttpd 08:04:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:04:11 INFO - Running setup.py install for mozinfo 08:04:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:04:11 INFO - Running setup.py install for mozInstall 08:04:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:04:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:04:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:04:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:04:11 INFO - Running setup.py install for mozleak 08:04:11 INFO - Running setup.py install for mozlog 08:04:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:04:11 INFO - Running setup.py install for moznetwork 08:04:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:04:11 INFO - Running setup.py install for mozprocess 08:04:11 INFO - Running setup.py install for mozprofile 08:04:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:04:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:04:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:04:11 INFO - Running setup.py install for mozrunner 08:04:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:04:12 INFO - Running setup.py install for mozscreenshot 08:04:12 INFO - Running setup.py install for moztest 08:04:12 INFO - Running setup.py install for mozversion 08:04:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:04:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:04:12 INFO - Cleaning up... 08:04:12 INFO - Return code: 0 08:04:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:04:12 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')]} 08:04:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:12 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')]} 08:04:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:12 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 0x10d51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1440a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1444090>, '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 0x1444d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x143ef90>, '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-1506351790.807965-1201926482', '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 08:04:12 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 08:04:12 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 08:04:12 INFO - Using env: {'DISPLAY': ':0', 08:04:12 INFO - 'HOME': '/home/cltbld', 08:04:12 INFO - 'LANG': 'en_US.UTF-8', 08:04:12 INFO - 'LANGUAGE': 'en_US:en', 08:04:12 INFO - 'LOGNAME': 'cltbld', 08:04:12 INFO - 'MAIL': '/var/mail/cltbld', 08:04:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:12 INFO - 'MOZ_NO_REMOTE': '1', 08:04:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:12 INFO - 'NO_EM_RESTART': '1', 08:04:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:12 INFO - 'PWD': '/builds/slave/test', 08:04:12 INFO - 'SHELL': '/bin/bash', 08:04:12 INFO - 'SHLVL': '1', 08:04:12 INFO - 'TERM': 'linux', 08:04:12 INFO - 'TMOUT': '86400', 08:04:12 INFO - 'USER': 'cltbld', 08:04:12 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1506351790.807965-1201926482', 08:04:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:12 INFO - '_': '/tools/buildbot/bin/python'} 08:04:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:04:12 INFO - Running setup.py (path:/tmp/pip-E7KAL7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:04:12 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:04:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:04:12 INFO - Running setup.py (path:/tmp/pip-0TeqAZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:04:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:04:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:04:12 INFO - Running setup.py (path:/tmp/pip-tSNbC7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:04:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:04:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:04:12 INFO - Running setup.py (path:/tmp/pip-YMqWIx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:04:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:04:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:04:12 INFO - Running setup.py (path:/tmp/pip-5hyvkf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:04:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:04:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:04:12 INFO - Running setup.py (path:/tmp/pip-dNMOBT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:04:13 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)) 08:04:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:04:13 INFO - Running setup.py (path:/tmp/pip-JgWKvH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:04:13 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)) 08:04:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:04:13 INFO - Running setup.py (path:/tmp/pip-6Lg__T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:04:13 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)) 08:04:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:04:13 INFO - Running setup.py (path:/tmp/pip-q1nq8J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:04:13 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)) 08:04:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:04:13 INFO - Running setup.py (path:/tmp/pip-Ayc0Nt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:04:13 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)) 08:04:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:04:13 INFO - Running setup.py (path:/tmp/pip-BvQjfd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:04:13 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)) 08:04:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:04:13 INFO - Running setup.py (path:/tmp/pip-4_sIKR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:04:13 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)) 08:04:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:04:13 INFO - Running setup.py (path:/tmp/pip-pr5ln4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:04:13 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)) 08:04:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:04:13 INFO - Running setup.py (path:/tmp/pip-lMxO3q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:04:13 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)) 08:04:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:04:13 INFO - Running setup.py (path:/tmp/pip-5VJOxo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:04:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:04:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:04:13 INFO - Running setup.py (path:/tmp/pip-TPbIih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:04:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:04:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:04:13 INFO - Running setup.py (path:/tmp/pip-FK0RG1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:04:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:04:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:04:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:04:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:04:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:04:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:04:13 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:04:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:04:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:04:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:04:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:04:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:04:14 INFO - Downloading blessings-1.6.tar.gz 08:04:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:04:14 INFO - Installing collected packages: blessings 08:04:14 INFO - Running setup.py install for blessings 08:04:15 INFO - Successfully installed blessings 08:04:15 INFO - Cleaning up... 08:04:15 INFO - Return code: 0 08:04:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:04:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:04:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:04:15 INFO - Reading from file tmpfile_stdout 08:04:15 INFO - Current package versions: 08:04:15 INFO - argparse == 1.2.1 08:04:15 INFO - blessings == 1.6 08:04:15 INFO - blobuploader == 1.2.4 08:04:15 INFO - docopt == 0.6.1 08:04:15 INFO - functools32 == 3.2.3-2 08:04:15 INFO - jsonschema == 2.5.1 08:04:15 INFO - manifestparser == 1.1 08:04:15 INFO - mozInstall == 1.13 08:04:15 INFO - mozcrash == 1.0 08:04:15 INFO - mozdebug == 0.1 08:04:15 INFO - mozdevice == 0.51 08:04:15 INFO - mozfile == 1.2 08:04:15 INFO - mozhttpd == 0.7 08:04:15 INFO - mozinfo == 0.10 08:04:15 INFO - mozleak == 0.1 08:04:15 INFO - mozlog == 3.5 08:04:15 INFO - moznetwork == 0.27 08:04:15 INFO - mozprocess == 0.25 08:04:15 INFO - mozprofile == 0.28 08:04:15 INFO - mozrunner == 6.13 08:04:15 INFO - mozscreenshot == 0.1 08:04:15 INFO - mozsystemmonitor == 0.3 08:04:15 INFO - moztest == 0.8 08:04:15 INFO - mozversion == 1.4 08:04:15 INFO - psutil == 3.1.1 08:04:15 INFO - requests == 1.2.3 08:04:15 INFO - wsgiref == 0.1.2 08:04:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:04:15 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')]} 08:04:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:15 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')]} 08:04:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:15 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 0x10d51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1440a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1444090>, '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 0x1444d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x143ef90>, '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-1506351790.807965-1201926482', '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 08:04:15 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 08:04:15 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 08:04:15 INFO - Using env: {'DISPLAY': ':0', 08:04:15 INFO - 'HOME': '/home/cltbld', 08:04:15 INFO - 'LANG': 'en_US.UTF-8', 08:04:15 INFO - 'LANGUAGE': 'en_US:en', 08:04:15 INFO - 'LOGNAME': 'cltbld', 08:04:15 INFO - 'MAIL': '/var/mail/cltbld', 08:04:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:15 INFO - 'MOZ_NO_REMOTE': '1', 08:04:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:15 INFO - 'NO_EM_RESTART': '1', 08:04:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:15 INFO - 'PWD': '/builds/slave/test', 08:04:15 INFO - 'SHELL': '/bin/bash', 08:04:15 INFO - 'SHLVL': '1', 08:04:15 INFO - 'TERM': 'linux', 08:04:15 INFO - 'TMOUT': '86400', 08:04:15 INFO - 'USER': 'cltbld', 08:04:15 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1506351790.807965-1201926482', 08:04:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:15 INFO - '_': '/tools/buildbot/bin/python'} 08:04:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:15 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)) 08:04:15 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)) 08:04:15 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)) 08:04:15 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)) 08:04:15 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)) 08:04:15 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)) 08:04:15 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)) 08:04:15 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)) 08:04:15 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)) 08:04:15 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 08:04:15 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 08:04:15 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 08:04:15 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 08:04:15 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 08:04:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 08:04:16 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:04:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:04:16 INFO - Installing collected packages: simplejson 08:04:16 INFO - Running setup.py install for simplejson 08:04:16 INFO - building 'simplejson._speedups' extension 08:04:16 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 08:04:17 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 08:04:17 INFO - Successfully installed simplejson 08:04:17 INFO - Cleaning up... 08:04:17 INFO - Return code: 0 08:04:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:04: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')]} 08:04:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04: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')]} 08:04:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1440a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1444090>, '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 0x1444d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x143ef90>, '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-1506351790.807965-1201926482', '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 08:04:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:04:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:04:17 INFO - Using env: {'DISPLAY': ':0', 08:04:17 INFO - 'HOME': '/home/cltbld', 08:04:17 INFO - 'LANG': 'en_US.UTF-8', 08:04:17 INFO - 'LANGUAGE': 'en_US:en', 08:04:17 INFO - 'LOGNAME': 'cltbld', 08:04:17 INFO - 'MAIL': '/var/mail/cltbld', 08:04:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:17 INFO - 'MOZ_NO_REMOTE': '1', 08:04:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:17 INFO - 'NO_EM_RESTART': '1', 08:04:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:17 INFO - 'PWD': '/builds/slave/test', 08:04:17 INFO - 'SHELL': '/bin/bash', 08:04:17 INFO - 'SHLVL': '1', 08:04:17 INFO - 'TERM': 'linux', 08:04:17 INFO - 'TMOUT': '86400', 08:04:17 INFO - 'USER': 'cltbld', 08:04:17 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1506351790.807965-1201926482', 08:04:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:17 INFO - '_': '/tools/buildbot/bin/python'} 08:04:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:04:18 INFO - Cleaning up... 08:04:18 INFO - Return code: 0 08:04:18 INFO - Running post-action listener: _resource_record_post_action 08:04:18 INFO - Running post-action listener: _start_resource_monitoring 08:04:18 INFO - Starting resource monitoring. 08:04:18 INFO - [mozharness: 2017-09-25 15:04:18.098254Z] Finished create-virtualenv step (success) 08:04:18 INFO - [mozharness: 2017-09-25 15:04:18.098764Z] Running install step. 08:04:18 INFO - Running pre-action listener: _resource_record_pre_action 08:04:18 INFO - Running main action method: install 08:04:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:04:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:04:18 INFO - Reading from file tmpfile_stdout 08:04:18 INFO - Detecting whether we're running mozinstall >=1.0... 08:04:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:04:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:04:18 INFO - Reading from file tmpfile_stdout 08:04:18 INFO - Output received: 08:04:18 INFO - Usage: mozinstall [options] installer 08:04:18 INFO - Options: 08:04:18 INFO - -h, --help show this help message and exit 08:04:18 INFO - -d DEST, --destination=DEST 08:04:18 INFO - Directory to install application into. [default: 08:04:18 INFO - "/builds/slave/test"] 08:04:18 INFO - --app=APP Application being installed. [default: firefox] 08:04:18 INFO - mkdir: /builds/slave/test/build/application 08:04:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:04:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:04:33 INFO - Reading from file tmpfile_stdout 08:04:33 INFO - Output received: 08:04:33 INFO - /builds/slave/test/build/application/firefox/firefox 08:04:33 INFO - Running post-action listener: _resource_record_post_action 08:04:33 INFO - [mozharness: 2017-09-25 15:04:33.005563Z] Finished install step (success) 08:04:33 INFO - [mozharness: 2017-09-25 15:04:33.005813Z] Running setup-mitmproxy step. 08:04:33 INFO - Running pre-action listener: _resource_record_pre_action 08:04:33 INFO - Running main action method: setup_mitmproxy 08:04:33 INFO - Skipping: mitmproxy is not required 08:04:33 INFO - Running post-action listener: _resource_record_post_action 08:04:33 INFO - [mozharness: 2017-09-25 15:04:33.006931Z] Finished setup-mitmproxy step (success) 08:04:33 INFO - [mozharness: 2017-09-25 15:04:33.007152Z] Running run-tests step. 08:04:33 INFO - Running pre-action listener: _resource_record_pre_action 08:04:33 INFO - Running pre-action listener: _set_gcov_prefix 08:04:33 INFO - Running main action method: run_tests 08:04:33 WARNING - Try message not found. 08:04:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:04:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:04:33 INFO - Python 2.7.3 08:04:33 INFO - Return code: 0 08:04:33 INFO - grabbing minidump binary from tooltool 08:04:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:04:33 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 0x1444090>, '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 0x1444d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x143ef90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:04:33 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 08:04:33 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 08:04:33 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 08:04:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:04:33 INFO - Return code: 0 08:04:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:04:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:04:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:04:33 INFO - ENV: RUST_BACKTRACE is now full 08:04:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:04:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:04:33 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/XNXT-O_xRDSxhs9chRjF3Q/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 08:04:33 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/XNXT-O_xRDSxhs9chRjF3Q/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 08:04:33 INFO - Using env: {'DISPLAY': ':0', 08:04:33 INFO - 'HOME': '/home/cltbld', 08:04:33 INFO - 'LANG': 'en_US.UTF-8', 08:04:33 INFO - 'LANGUAGE': 'en_US:en', 08:04:33 INFO - 'LOGNAME': 'cltbld', 08:04:33 INFO - 'MAIL': '/var/mail/cltbld', 08:04:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:04:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:04:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:33 INFO - 'MOZ_NO_REMOTE': '1', 08:04:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:04:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:33 INFO - 'NO_EM_RESTART': '1', 08:04:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:33 INFO - 'PWD': '/builds/slave/test', 08:04:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:04:33 INFO - 'RUST_BACKTRACE': 'full', 08:04:33 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 08:04:33 INFO - 'SHELL': '/bin/bash', 08:04:33 INFO - 'SHLVL': '1', 08:04:33 INFO - 'TERM': 'linux', 08:04:33 INFO - 'TMOUT': '86400', 08:04:33 INFO - 'USER': 'cltbld', 08:04:33 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1506351790.807965-1201926482', 08:04:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:33 INFO - '_': '/tools/buildbot/bin/python'} 08:04:33 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/XNXT-O_xRDSxhs9chRjF3Q/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 08:04:33 INFO - mozversion application_buildid: 20170925134255 08:04:33 INFO - mozversion application_changeset: 8158695b90e423f6eb559ac90ee967f196afd44f 08:04:33 INFO - mozversion application_display_name: Firefox 08:04:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:04:33 INFO - mozversion application_name: Firefox 08:04:33 INFO - mozversion application_remotingname: firefox 08:04:33 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 08:04:33 INFO - mozversion application_vendor: Mozilla 08:04:33 INFO - mozversion application_version: 57.0 08:04:33 INFO - mozversion platform_buildid: 20170925134255 08:04:33 INFO - mozversion platform_changeset: 8158695b90e423f6eb559ac90ee967f196afd44f 08:04:33 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 08:04:33 INFO - mozversion platform_version: 57.0 08:04:33 INFO - using testdate: 1506351873 08:04:33 INFO - actual date: 1506351873 08:04:33 INFO - starting webserver on 'localhost:60793' 08:04:33 INFO - SUITE-START | Running 2 tests 08:04:33 INFO - TEST-START | dromaeo_css 08:04:33 INFO - Initialising browser for dromaeo_css test... 08:04:33 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:60793/getInfo.html -profile /tmp/tmpTqwSYy/profile 08:04:33 INFO - TEST-INFO | started process 26809 (/builds/slave/test/build/application/firefox/firefox http://localhost:60793/getInfo.html) 08:04:38 INFO - TEST-INFO | 26809: exit 0 08:04:39 INFO - Browser initialized. 08:04:39 INFO - Running cycle 1/1 for dromaeo_css test... 08:04:39 INFO - Using env: {'DISPLAY': ':0', 08:04:39 INFO - 'HOME': '/home/cltbld', 08:04:39 INFO - 'JSGC_DISABLE_POISONING': '1', 08:04:39 INFO - 'LANG': 'en_US.UTF-8', 08:04:39 INFO - 'LANGUAGE': 'en_US:en', 08:04:39 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 08:04:39 INFO - 'LOGNAME': 'cltbld', 08:04:39 INFO - 'MAIL': '/var/mail/cltbld', 08:04:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:04:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:04:39 INFO - 'MOZ_CRASHREPORTER': '1', 08:04:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:39 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 08:04:39 INFO - 'MOZ_NO_REMOTE': '1', 08:04:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:04:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:39 INFO - 'NO_EM_RESTART': '1', 08:04:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:39 INFO - 'PWD': '/builds/slave/test', 08:04:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:04:39 INFO - 'RUST_BACKTRACE': 'full', 08:04:39 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 08:04:39 INFO - 'SHELL': '/bin/bash', 08:04:39 INFO - 'SHLVL': '1', 08:04:39 INFO - 'TERM': 'linux', 08:04:39 INFO - 'TMOUT': '86400', 08:04:39 INFO - 'USER': 'cltbld', 08:04:39 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1506351790.807965-1201926482', 08:04:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:39 INFO - '_': '/tools/buildbot/bin/python'} 08:04:39 INFO - TEST-INFO | started process 27000 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTqwSYy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 08:04:39 INFO - PID 27000 | 08:04:39 INFO - PID 27000 | (/builds/slave/test/build/application/firefox/firefox:27049): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 08:04:39 INFO - PID 27000 | 08:04:50 INFO - PID 27000 | RSS: Main: 141504512 08:04:50 INFO - PID 27000 | 08:07:47 INFO - PID 27000 | Cycle 1(1): loaded http://localhost:60793/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60793/tests/dromaeo/cssquery-ext.html) 08:07:48 INFO - PID 27000 | RSS: Main: 145326080 08:07:48 INFO - PID 27000 | 08:10:50 INFO - PID 27000 | Cycle 1(1): loaded http://localhost:60793/tests/dromaeo/cssquery-ext.html (next: http://localhost:60793/tests/dromaeo/cssquery-jquery.html) 08:10:50 INFO - PID 27000 | RSS: Main: 143691776 08:10:50 INFO - PID 27000 | 08:13:52 INFO - PID 27000 | Cycle 1(1): loaded http://localhost:60793/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60793/tests/dromaeo/cssquery-mootools.html) 08:13:53 INFO - PID 27000 | RSS: Main: 144822272 08:13:53 INFO - PID 27000 | 08:16:54 INFO - PID 27000 | Cycle 1(1): loaded http://localhost:60793/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60793/tests/dromaeo/cssquery-prototype.html) 08:16:55 INFO - PID 27000 | RSS: Main: 143663104 08:16:55 INFO - PID 27000 | 08:19:58 INFO - PID 27000 | Cycle 1(1): loaded http://localhost:60793/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60793/tests/dromaeo/cssquery-yui.html) 08:19:58 INFO - PID 27000 | RSS: Main: 146653184 08:19:58 INFO - PID 27000 | 08:23:00 INFO - PID 27000 | Cycle 1(1): loaded http://localhost:60793/tests/dromaeo/cssquery-yui.html (next: http://localhost:60793/tests/dromaeo/cssquery-dojo.html) 08:23:00 INFO - PID 27000 | RSS: Main: 148721664 08:23:00 INFO - PID 27000 | 08:23:00 INFO - PID 27000 | __start_tp_report 08:23:00 INFO - PID 27000 | _x_x_mozilla_page_load 08:23:00 INFO - PID 27000 | _x_x_mozilla_page_load_details 08:23:00 INFO - PID 27000 | |i|pagename|runs| 08:23:00 INFO - PID 27000 | |0;dojo.html;4028.274910516107;4034.5360283567397;4037.4145748866417;4057.0871553900392;4057.939130913037;6416.037594360848;6453.064305675674;6456.451201647854;6566.080748695186;6581.506387020974;6471.223453185625;6489;6504.73981040759;6562.606243625386;6586.901196482045;5778.219940308047;5799.507041901444;5805.622634528763;5832.6792026438525;5843.5033022193165;5727.11229759388;5795.1886735857015;5804.709764511778;5807.767689292423;5909.0250108732225;5777.42225777421;5783;5832.912506312408;5839.7664093436215;5904.409559044083;5794.159846822229;5880;5930.614510056854;5948.137520059568;5965.61223520472;5681.375048744635;5744.138379243105;5780.132980052984;5813.88372232553;5978.55160862937;6331.715072821688;6376.649284289362;6385.850546901556;6410.8076757697345;6476.90284645726;6990.6155161466095;7029.789106326818;7049.859002819915;7121.786346409616;7133.144022717255;7020.824479388005;7073.787786366417;7077.2568880267345;7137.2149063602965;7154.35610795031;6596.373344532358;6612.603243805387;6641.933580664228;6647.900281495733;6654.367835055662;7220.783376498714;7236.565806051653;7245.8550828983125;7340.926590734024;7354.963225183947;6811.352921472452;6927.376536111673;6952.617606031616;6957.860842783116;7044.542104763174;7055.294470553006;7078.539894906815;7078.893816592756;7087.078679771596;7169.605671688108;6936.167659880846;6943.618101004493;7059.294070593002;7087.0432491614;7135.357817796424;6949.687264073129;7046.295370462913;7059.717611295593;7072.222055573883;7136.0723105995885;5099.107656160157;5111.795528178905;5119.078565858107;5149.588032957355;5164.147915593885;4763.476017638057;4827.927581086286;4830.203016502238;4834.347363106006;4858.878528036827;6635.635040072746;6726.428253598499;6781.321867813278;6804.4216241620015;6810.897836532456;7096.964515177391;7110.1112360954885;7184.892226616605;7185.856282874313;7195.316444937723;6584.407403333723;6682.465402767767;6689.665516724242;6690.464762818963;6721.66391680414;5889.734961926723;5962.522998160137;5968.432998865101;5971.5222782177325;5972.731227094791;7281.4538909582;7305.293712632698;7308.37878780299;7480.326770590673;7488.438367122379;7115.075040244735;7141.285871413025;7170.713171473083;7185.604791736505;7201.747938822116;7452.627368631655;7460.465208886092;7470.626468676436;7519.661615227218;7570.091589009354;6944.583325000516;6999.965000175171;7003.789886303419;7087.291270872872;7145.1068616422945;7121.82195445118;7132.1441427029085;7138.321859423347;7152.9284707152265;7171.641417929187;6812.931870681428;6819.488538359544;6843.726250950105;6910.44716422695;6915.585064896122;6774.796756097325;6791.592504449749;6811.455083593201;6875.1749790025515;6885.380315771605;6669.333066693292;6778.3221677831825;6780.118584583973;6805.489588280998;6836;6720;6944.4097251734165;6969.128858892638;6969.233384327821;7020.438364930896;6633.834154146185;6640.800775976729;6676.49926255523;6737.29258427858;6739.6967136478 08:23:00 INFO - PID 27000 | |1;ext.html;930.4510338900047;968.6319198704491;983.7983213441245;1030.7217051396124;1037.559037409101;45299.77350113249;46231.537684623145;46239.53760462395;46244.306335404995;46351;43710.344344834775;43847.780761096226;43879.561204387945;43882.780586097106;43985;8204.507729536217;8283.544405057719;8295.294899933513;8318.209770071864;8326.958365208166;7928.722494712686;7964.482308649919;7972.282494575487;7992.120866704658;8163.714270000552;8334.083250842403;8382.748517544484;8384.958075209615;8433.114522975091;8449.619767110464;8241.670333186696;8331.33349332052;8340.249377556018;8365.665373385058;8404.663813447454;8812.16284452976;8832.33757468186;8917.509536975464;8920.910790892072;8954.910450895539;42143.1571368574;42515.787421063;42536.78731606322;42817;42824.78587607042;3848.5189351331082;3849.480320156771;3879.8448062077764;3881.3013657541633;3893.8637147699696;34781.82609086964;34909.650903490896;35049.299014019576;35082.649173508195;35085.47371789425;5432.75552600134;5465.152901300305;5467.097928841737;5511.53151982082;5521.309836270466;238239;238563;238850;239498.99999999825;239772;55321.44678553243;55336.72331638316;55380.72309638507;55393;55506.444935550935;57671;58036.70981645149;58126;58146.22049566764;58222;18851.622967540574;19009.334673286645;19009.714854277197;19017.429477115707;19034.904825475784;15538.300776465087;15547.84452155464;15601.141937193337;15603.843961560238;15609.687806243812;15309.846901530842;15327;15397.692046159014;15400.768988465183;15542.844571554366;5819.883602328015;5831.737571809279;5875.676837773964;5928.555358348141;5936;1081.1620993729923;1111.9214362068942;1120.2326406411635;1120.9327440353604;1121.1943502937256;26968.190954271402;27294.863525682245;27421.451570968467;27614.861925690242;27687;1216.555957075661;1221.2001139253803;1225.6489462408415;1238.6717519857245;1243.6704273367566;13978;14156.36296366666;14204.360803763855;14468.493602724066;14621.415143394144;319521;322452;323457;323758;324463;54407;55158;55381.446185538436;63237.36762632407;63407.6829615849;1509.7131545006632;1540.9383624654888;1547.2263868066193;1554.0830909763295;1558.2442515380258;33120;33434.832825835714;33464.665353347125;33550;33908.321833563685;41974;42989.35515967326;43322.78338608287;43339;43379.566204337556;237756;238029;238561;239528;240400;38178.618213817506;38349.808250959686;38481.42277865778;38854;38923.416148758355;50639;51880.74059629829;52029.479705202466;52084.47915520796;52203.47796521986;37211.6278837219;37336.813315934334;37408.43887341637;37449.81275093607;37532.81233593814;36785.26429471449;37224.81387593153;37233.25533489261;37301.4404783923;37359;42616.57383426126;44178.55821441873;44232;44380.11239775251;44675.77662111669;34716.47925281173;35417.645823542465;35518.644813552564;35710.42895710408;36230;26576.7342326582;26596;26881.731182687923;27207.183784486497;27446.394931066417 08:23:00 INFO - PID 27000 | |2;jquery.html;631.141762305106;636.2672322375397;637.7247688611711;648.0887792848335;656.791503633315;23981.76018239817;24443.144489942857;24587.139450119248;24685.75314246857;24832.255032349058;25967.22098337048;26211.47577048458;26363.20910372687;26382.20853374397;26445.86777066112;6666.166729158843;6940.2712715164935;6944;6945.930540694604;6968.372846443819;6904.75833345833;6955.374016338528;6962.512624116314;6965.721371145148;6966.268541803113;6916.930830691704;6920.307969203064;6921.273266307016;6922.861542769142;6937.583744975293;6835.829104272383;6913.75801846933;6925.688344024531;6930.653467326639;6949.096617439725;6410.0705397717065;6428.035794630796;6450.129232553592;6471.579347342407;6496.9675151624415;31622.683773162204;32188.356232875445;32214;32294.515582266285;32351.191220219447;2390.7250666173263;2391.9521609567887;2420.1529464687396;2422.6608274841537;2427.757224277576;20838.5832283355;21132.788672113234;21617.67573486399;22375.440613984618;22484.550308993894;2642.8017898657486;2647.7219891911263;2683.9329016774736;2684.3020814588153;2696.649435573363;136837;144234;168657;174102;175357;17116.229769660396;17371.218295176746;17721.379751708628;17919.259613850307;17994.730079048826;27173.456530869273;27249.727502725116;27442.862785685942;27448.17655470339;27448.588271175948;11858.525658973716;11963.58127465552;12023.458944347525;12158.562124824552;12164.56708658272;11215.439228038565;11236;11256.662300131009;11269.605563805391;11306;10584.153267738562;10674.519646615921;10699.25105242641;10728.94635526833;10792.46037698112;2866.4553734790325;2916.1688918658506;2973.9702602974126;3002.639683237982;3115.501519756828;1059.2743970380313;1060.9840852387065;1066.6746642274027;1070.796548655753;1086.6468397770757;21330.253441129797;21832;22006;22193.44516387103;22415.66376504321;1148.7771162800009;1151.0848875144281;1156.2657712352548;1158.478684591937;1162.8372027916098;11794.587189448328;11905.98799102086;12002.239484918344;12063.914247717572;12345.753084938251;716635;718180;730422;732748;748612;136604.31697841448;137554;140923;141028;141097.29451352678;1272.993635031819;1278.1883503975043;1292.6251387097825;1293.0625296659846;1296.4490091710986;18843.717344239572;19093;19118.139683714544;19134.904325478285;19226.519337016685;62090.37909620846;62311;62484;63654.68172659107;65172.348276516626;82814;83109.58445207735;83648.58175709083;83683.16316836997;84496;16258.430954916521;16428.42500512476;16483.093429861474;16534;16594.087325196746;24718.382040449134;24760.628590570795;24825.751742483066;24880.12919547807;25158.119465818607;19980.3006894758;20450;20523.384298471068;20607;20626;17479.038652873704;17869.821301786815;17960.281588736303;18254.72617910759;18463.630727385647;20529.486762830453;20544.972751362075;20657.17371305131;20791;20878.060487277806;15834.841651583798;16003.839961600701;16019.839801601835;16035.438759643357;16113;17198;17399;19861.702074468605;20203.79796202019;20354.694679580116 08:23:00 INFO - PID 27000 | |3;mootools.html;1444.8410674825768;1485.9331330090145;1499.4452052740487;1524.969500609987;1533.0724911428586;17041.744373834386;17666.734998975026;17774.822251777478;17775.28898844046;17787.82212177878;17303.39438119666;17485.125743712826;17490;17497.825021749777;17500.56248593786;3104.518799586068;3123.437781199383;3158.44727172745;3171.2389026633673;3179.554862319277;3055.648600410948;3079.55346474761;3090.8300043497597;3093.6596974332806;3095.272610936428;3000.834954077525;3039.1642298368015;3065.417570661567;3165.1612322734495;3166.509191075387;3104.720575148236;3109.67348428414;3138.968610313902;3145.5753473281156;3153.180173154973;2996.475616767057;3058.9847050764824;3073.1702440340982;3087.706667866549;3091.48990416581;16849.91575042117;17227.483175504756;17327.826721732872;17354.826451735447;17372.47882563525;9156.404833685789;9452.57463414148;9463.763405914839;9480.194183494412;9481.47851868147;5632.971835140839;5643.774249030034;6012.909806352908;6030.09548567714;6043.153958445821;2057.444489987695;2060.5054786851197;2075.2632815350635;2109.4199095248778;2142;30971.915982940714;31009;31082;31182;31190.532142017888;7485.700571977169;7709.113451953097;7850.6859725611475;7868.724594639275;7978.122406535276;20530.38408847737;20589.38231853047;20616.175352985712;20739.896300518703;20756.169753210004;8608.569571521399;8795.868061979076;8796.692115775917;8810.77973050666;8821.161989610977;8055.919440805634;8090.312323452455;8291.33669306454;8497.74506764798;8524.914750852537;5985.910211346833;6229.906337404333;6252.437280644764;6252.968735156295;6373.330800265905;1706.709859323918;1749.422690512128;1761.5948331883737;1778.3509019207895;1805.7742782152231;830.2610676497922;985.1970643925179;1019.8164330420448;1023.2581378500677;1035.3270374256792;9602.84765828091;9613.471259080678;9827.4103553787;9865.605375784888;10013.29906906524;824.8556502612139;827.8634025385744;839.630562552475;853.5220276645099;910.0717268386209;6244.562880598314;6283.120363149163;6403.903941440882;6528.151340325728;6557.836054098686;25039;26452.338691532867;26754.5986810198;27012.594811077848;27069.052583159493;26429.603555946676;26730.930762769272;26984.730152698616;27341.769620367133;27571.31071723223;12356.196847205083;12510.249385036926;12556.497740090294;12587.62237132869;12599.307038112991;9945.353552019096;10033.347832390871;10233.283670143317;10359.896401035892;10441.791164176522;22447.21434749776;22680.319590412313;22867;22926.312210633707;22938.770612293665;23685.17101901425;23728.644070339305;23872.28383148508;24082.51834963326;24409.26772196837;12937.805932911202;13012.349382530647;13148.211107333591;13158;13162.078654494477;16089.919550402174;16376.099314537814;16523.917380413022;16531.752023719895;16596.419125330554;12549.372531373578;12987;13041.739165216453;13371.465141394625;13416.32918354098;12333.383330833243;12432.005439564993;12474.750504989668;12676;12820.23078615286;10685.412302323446;10717.732056698645;10792.514336855018;10855.945720271347;10880.727981800519;8083.110857805755;8100.554469504234;8138.83722325562;8139.232660895324;8151.714689985822;8473;8474.898263225741;8533.643683820474;8567.571621419029;8576.313894888519 08:23:00 INFO - PID 27000 | |4;prototype.html;577.5581680014786;582.6242073862359;590.1030433740714;596.1504855580796;616.4298024327496;6276.184096067511;6302.621842689437;6339.936600633992;6382.702227198205;6431.678416079189;6209.130721698965;6246.687665616723;6257.71840267188;6278.68606569672;6279.843003924904;5133.204353325241;5169.40551836538;5174.844754657366;5181.222816577525;5181.844544663666;4926.261060840867;5148.253503242027;5163.586913046947;5170.793168273283;5200.505951934579;4982.676126051795;4986;5016.247562865581;5031.345925029741;5047.242913562976;4974.950250497485;4977.452480227172;5020.824271150511;5028.522290382408;5048.066107770074;4504.842330518416;4543.091381723669;4580.7938642761155;4584.472785629662;4593.63250939924;6178.938210617881;6204.565680402374;6240.001599744064;6245.5628106032145;6253.873682947774;5943.227380440515;5995.550333724988;6005.519558435315;6006.159137720722;6023.518118550549;6629.547067585025;6646.933530664728;6657.76697815579;6708.865822683519;6725.461963042945;5058.974705126488;5082.695038297714;5152.742362881841;5154.12379895415;5188.221766734982;6729.966350168267;6840.726370945156;6890.1731792184755;6975.790726278169;6982.26686197952;5234.42421333653;5249.265102885599;5264.763085661154;5321.09541377959;5351;5302.878848460647;5372.8656783579945;5377.193420986805;5380.300560927054;5424.593155513273;5864.149698293723;5957.017092179742;5960.1059841023325;5987.461128498456;6010.557466208079;6728.400305836354;6779;6787;6792.320767923168;6813.420859226922;1830.432565904574;1834.2937968882077;1851.0837135617955;1867.71984202368;1869.1962456143988;1287.8840904318656;1310.0960337367187;1317.2228385252747;1336.3719052045524;1336.432016393029;6220.968895155585;6265.655388953652;6343.524235682342;6389.552731308764;6409.615423074631;6759.493038022168;6764.932350676529;6769.796906092825;6840.144981877265;6861.696277707219;6308.936910630927;6369.484053798724;6404.903926441107;6417.74329026843;6435.839104022437;3549.396602577568;3570.732195085379;3586.8206589670413;3598.7300952428673;3604.2611264690677;7109.1824440189;7132;7147.749828755968;7167.820804479929;7176.497645164788;6947.652617369111;6953.652317384111;7001.159860816632;7017;7087.964560177166;6964.015255652115;7002.40479559233;7016.509139255593;7020.333068358498;7035.8286659306395;6706.631135287606;6752.831179220559;6754.142610782074;6792.93207067923;6832.350926662158;6691.59850408977;6724.831879203059;6759.966200168968;6780.694868731018;6806.897896531655;6981.930180698128;6997.96501017512;7017.824554386181;7082.114735658043;7226.855462890608;5243.239730239017;5312.62811603184;5314.681119132864;5315.229291752751;5322.866928326823;6526.510511711545;6573.375529324707;6740.921452567762;6813.557118787263;6834.589924604539;6488.935110648833;6582.967085164543;6606.8017959461295;6660.467162627075;6690.591387100542;6569.178852643419;6582.703778329891;6605.636689982097;6643.867122657616;6673.499487538357;6310.305866354789;6495.823898993701;6540.313267107075;6582.1443212384;6619.172603424572;6628.502862285444;6692.765753198614;6707.195136583446;6732.057511948233;6746.4265537429865;6468.611883287018;6520.282768895512;6572.868542629025;6591.406773390418;6592.505562082767 08:23:00 INFO - PID 27000 | |5;yui.html;897.8877640294963;923.2475532441056;939.0843927171005;997.9770734996628;1031.0411317474748;20825;21628.2430114946;21629.891850540746;21783;21802.672959905613;19584;19715.605687886233;19717.35228982639;19743.308984185558;19961;1085.2620218251586;1088.521050737677;1088.7768007558432;1089.1069323155016;1089.7874914391696;1056.878458977216;1083.864516935383;1089.3953855610134;1091.4488183467377;1093.606301731376;1170.3563040327829;1171.800793865045;1172.8827117288288;1173.6185739634611;1177.370106992759;1154.59589143799;1156.8727439981594;1157.5196293538213;1159.9246049006829;1165.8192980088015;854.3378881366929;855.9186877246714;857.1428571428571;863.952482613456;865.6277800545763;20837.89581052085;20975.16099356024;21158.788412115835;21178.25876094345;21735.565288694295;20384.898075509675;20442;20710.17159313641;20742.792572074388;20750.48123796902;17927.551811204692;17987.370442034466;18060.729089063676;18131;18214.27142914282;4002.899927501807;4012.879613611596;4025.698072644534;4045.5145382553987;4054.837806487737;147462;158641;161482;161771;168735;18659.346922857636;19411.611767764567;19413.708794368096;19430.514237144183;19432.611347772967;31143.377132457677;31971;32112.518312225337;32323.676763232535;32339.51490727641;9533.332666713402;9534.713958581253;9584.041595840361;9588.616455341707;9590.472524011246;4752.928706069411;4802.423709154924;4814.253790662453;4816.95183048165;4825.034993001414;6422.903656445157;6423.807285781434;6465.547411681231;6493.577917435352;6523.902141467882;1257.798752199662;1273.7452509498137;1279.0087682046303;1289.6389011076913;1294.0876681939399;768.3660979691776;776.6078130544039;782.2060608482395;796.0725754495948;807.2532907061062;12738;12877.935610321889;13632.93183534076;13833.239171845646;13851.792223116661;759.4076620236115;763.171958425115;763.4350580570338;766.371575308253;777.1412589089089;6023.759049637965;6149.938500614937;6186.4741496973265;6211.937880621226;6216.502679785606;155604.22197888937;156393;158327;159151;160797;112022.87977120125;124621;142694;143515.2824235893;143564;119162;122586.38706806408;123454;126075.3696231513;127107.36446317709;13889.374978125807;14115.364808583434;14191.64520886986;14200.715985680023;14320.06919550226;58475.4152458487;58679.41320586739;58982.70508647429;60056;60473;75792.24207757851;77555;77711.74368330202;78262;78681.60659196667;19214.654974151676;19220.71168932439;19757.604847902672;19872.205111795945;20168.49578760543;19672.606547869247;19808.801911980696;20027.45531051322;20106.899465502578;20356.389308320773;20087;20276.290329838386;20372.69440958357;20410.489737756674;20530.589388211854;19492.902535487232;19521.316753913547;19718.40844774659;19827.603447931248;19876.00619968967;19864.404067877986;19963.301284454974;20025.49936251547;20039.899800500905;20121.094550744958;15108.54674359771;15494.612634684223;15544.844551554339;15581.610459738144;15609.921950390175;15062.189984795146;15312.464063757716;15377.154256516;15478.226088695295;15643.687126257184 08:23:00 INFO - PID 27000 | __end_tp_report 08:23:00 INFO - PID 27000 | __start_cc_report 08:23:00 INFO - PID 27000 | _x_x_mozilla_cycle_collect,251 08:23:00 INFO - PID 27000 | __end_cc_report 08:23:00 INFO - PID 27000 | __startTimestamp1506352980297__endTimestamp 08:23:00 INFO - PID 27000 | 08:23:00 INFO - PID 27000 | ------- Summary: start ------- 08:23:00 INFO - PID 27000 | Number of tests: 6 08:23:00 INFO - PID 27000 | 08:23:00 INFO - PID 27000 | [#0] dojo.html Cycles:165 Average:6532.16 Median:6781.32 stddev:775.56 (11.4%) stddev-sans-first:752.65 08:23:00 INFO - PID 27000 | Values: 4028.3 4034.5 4037.4 4057.1 4057.9 6416.0 6453.1 6456.5 6566.1 6581.5 6471.2 6489.0 6504.7 6562.6 6586.9 5778.2 5799.5 5805.6 5832.7 5843.5 5727.1 5795.2 5804.7 5807.8 5909.0 5777.4 5783.0 5832.9 5839.8 5904.4 5794.2 5880.0 5930.6 5948.1 5965.6 5681.4 5744.1 5780.1 5813.9 5978.6 6331.7 6376.6 6385.9 6410.8 6476.9 6990.6 7029.8 7049.9 7121.8 7133.1 7020.8 7073.8 7077.3 7137.2 7154.4 6596.4 6612.6 6641.9 6647.9 6654.4 7220.8 7236.6 7245.9 7340.9 7355.0 6811.4 6927.4 6952.6 6957.9 7044.5 7055.3 7078.5 7078.9 7087.1 7169.6 6936.2 6943.6 7059.3 7087.0 7135.4 6949.7 7046.3 7059.7 7072.2 7136.1 5099.1 5111.8 5119.1 5149.6 5164.1 4763.5 4827.9 4830.2 4834.3 4858.9 6635.6 6726.4 6781.3 6804.4 6810.9 7097.0 7110.1 7184.9 7185.9 7195.3 6584.4 6682.5 6689.7 6690.5 6721.7 5889.7 5962.5 5968.4 5971.5 5972.7 7281.5 7305.3 7308.4 7480.3 7488.4 7115.1 7141.3 7170.7 7185.6 7201.7 7452.6 7460.5 7470.6 7519.7 7570.1 6944.6 7000.0 7003.8 7087.3 7145.1 7121.8 7132.1 7138.3 7152.9 7171.6 6812.9 6819.5 6843.7 6910.4 6915.6 6774.8 6791.6 6811.5 6875.2 6885.4 6669.3 6778.3 6780.1 6805.5 6836.0 6720.0 6944.4 6969.1 6969.2 7020.4 6633.8 6640.8 6676.5 6737.3 6739.7 08:23:00 INFO - PID 27000 | 08:23:00 INFO - PID 27000 | [#1] ext.html Cycles:180 Average:45592.28 Median:21165.45 stddev:70216.42 (331.8%) stddev-sans-first:70333.32 08:23:00 INFO - PID 27000 | Values: 930.5 968.6 983.8 1030.7 1037.6 45299.8 46231.5 46239.5 46244.3 46351.0 43710.3 43847.8 43879.6 43882.8 43985.0 8204.5 8283.5 8295.3 8318.2 8327.0 7928.7 7964.5 7972.3 7992.1 8163.7 8334.1 8382.7 8385.0 8433.1 8449.6 8241.7 8331.3 8340.2 8365.7 8404.7 8812.2 8832.3 8917.5 8920.9 8954.9 42143.2 42515.8 42536.8 42817.0 42824.8 3848.5 3849.5 3879.8 3881.3 3893.9 34781.8 34909.7 35049.3 35082.6 35085.5 5432.8 5465.2 5467.1 5511.5 5521.3 238239.0 238563.0 238850.0 239499.0 239772.0 55321.4 55336.7 55380.7 55393.0 55506.4 57671.0 58036.7 58126.0 58146.2 58222.0 18851.6 19009.3 19009.7 19017.4 19034.9 15538.3 15547.8 15601.1 15603.8 15609.7 15309.8 15327.0 15397.7 15400.8 15542.8 5819.9 5831.7 5875.7 5928.6 5936.0 1081.2 1111.9 1120.2 1120.9 1121.2 26968.2 27294.9 27421.5 27614.9 27687.0 1216.6 1221.2 1225.6 1238.7 1243.7 13978.0 14156.4 14204.4 14468.5 14621.4 319521.0 322452.0 323457.0 323758.0 324463.0 54407.0 55158.0 55381.4 63237.4 63407.7 1509.7 1540.9 1547.2 1554.1 1558.2 33120.0 33434.8 33464.7 33550.0 33908.3 41974.0 42989.4 43322.8 43339.0 43379.6 237756.0 238029.0 238561.0 239528.0 240400.0 38178.6 38349.8 38481.4 38854.0 38923.4 50639.0 51880.7 52029.5 52084.5 52203.5 37211.6 37336.8 37408.4 37449.8 37532.8 36785.3 37224.8 37233.3 37301.4 37359.0 42616.6 44178.6 44232.0 44380.1 44675.8 34716.5 35417.6 35518.6 35710.4 36230.0 26576.7 26596.0 26881.7 27207.2 27446.4 08:23:00 INFO - PID 27000 | 08:23:00 INFO - PID 27000 | [#2] jquery.html Cycles:180 Average:44269.87 Median:22099.72 stddev:121199.69 (548.4%) stddev-sans-first:121495.40 08:23:00 INFO - PID 27000 | Values: 631.1 636.3 637.7 648.1 656.8 23981.8 24443.1 24587.1 24685.8 24832.3 25967.2 26211.5 26363.2 26382.2 26445.9 6666.2 6940.3 6944.0 6945.9 6968.4 6904.8 6955.4 6962.5 6965.7 6966.3 6916.9 6920.3 6921.3 6922.9 6937.6 6835.8 6913.8 6925.7 6930.7 6949.1 6410.1 6428.0 6450.1 6471.6 6497.0 31622.7 32188.4 32214.0 32294.5 32351.2 2390.7 2392.0 2420.2 2422.7 2427.8 20838.6 21132.8 21617.7 22375.4 22484.6 2642.8 2647.7 2683.9 2684.3 2696.6 136837.0 144234.0 168657.0 174102.0 175357.0 17116.2 17371.2 17721.4 17919.3 17994.7 27173.5 27249.7 27442.9 27448.2 27448.6 11858.5 11963.6 12023.5 12158.6 12164.6 11215.4 11236.0 11256.7 11269.6 11306.0 10584.2 10674.5 10699.3 10728.9 10792.5 2866.5 2916.2 2974.0 3002.6 3115.5 1059.3 1061.0 1066.7 1070.8 1086.6 21330.3 21832.0 22006.0 22193.4 22415.7 1148.8 1151.1 1156.3 1158.5 1162.8 11794.6 11906.0 12002.2 12063.9 12345.8 716635.0 718180.0 730422.0 732748.0 748612.0 136604.3 137554.0 140923.0 141028.0 141097.3 1273.0 1278.2 1292.6 1293.1 1296.4 18843.7 19093.0 19118.1 19134.9 19226.5 62090.4 62311.0 62484.0 63654.7 65172.3 82814.0 83109.6 83648.6 83683.2 84496.0 16258.4 16428.4 16483.1 16534.0 16594.1 24718.4 24760.6 24825.8 24880.1 25158.1 19980.3 20450.0 20523.4 20607.0 20626.0 17479.0 17869.8 17960.3 18254.7 18463.6 20529.5 20545.0 20657.2 20791.0 20878.1 15834.8 16003.8 16019.8 16035.4 16113.0 17198.0 17399.0 19861.7 20203.8 20354.7 08:23:00 INFO - PID 27000 | 08:23:00 INFO - PID 27000 | [#3] mootools.html Cycles:180 Average:10964.62 Median:27205.41 stddev:8100.69 (29.8%) stddev-sans-first:8091.84 08:23:00 INFO - PID 27000 | Values: 1444.8 1485.9 1499.4 1525.0 1533.1 17041.7 17666.7 17774.8 17775.3 17787.8 17303.4 17485.1 17490.0 17497.8 17500.6 3104.5 3123.4 3158.4 3171.2 3179.6 3055.6 3079.6 3090.8 3093.7 3095.3 3000.8 3039.2 3065.4 3165.2 3166.5 3104.7 3109.7 3139.0 3145.6 3153.2 2996.5 3059.0 3073.2 3087.7 3091.5 16849.9 17227.5 17327.8 17354.8 17372.5 9156.4 9452.6 9463.8 9480.2 9481.5 5633.0 5643.8 6012.9 6030.1 6043.2 2057.4 2060.5 2075.3 2109.4 2142.0 30971.9 31009.0 31082.0 31182.0 31190.5 7485.7 7709.1 7850.7 7868.7 7978.1 20530.4 20589.4 20616.2 20739.9 20756.2 8608.6 8795.9 8796.7 8810.8 8821.2 8055.9 8090.3 8291.3 8497.7 8524.9 5985.9 6229.9 6252.4 6253.0 6373.3 1706.7 1749.4 1761.6 1778.4 1805.8 830.3 985.2 1019.8 1023.3 1035.3 9602.8 9613.5 9827.4 9865.6 10013.3 824.9 827.9 839.6 853.5 910.1 6244.6 6283.1 6403.9 6528.2 6557.8 25039.0 26452.3 26754.6 27012.6 27069.1 26429.6 26730.9 26984.7 27341.8 27571.3 12356.2 12510.2 12556.5 12587.6 12599.3 9945.4 10033.3 10233.3 10359.9 10441.8 22447.2 22680.3 22867.0 22926.3 22938.8 23685.2 23728.6 23872.3 24082.5 24409.3 12937.8 13012.3 13148.2 13158.0 13162.1 16089.9 16376.1 16523.9 16531.8 16596.4 12549.4 12987.0 13041.7 13371.5 13416.3 12333.4 12432.0 12474.8 12676.0 12820.2 10685.4 10717.7 10792.5 10855.9 10880.7 8083.1 8100.6 8138.8 8139.2 8151.7 8473.0 8474.9 8533.6 8567.6 8576.3 08:23:00 INFO - PID 27000 | 08:23:00 INFO - PID 27000 | [#4] prototype.html Cycles:180 Average:5704.01 Median:6325.12 stddev:1582.89 (25.0%) stddev-sans-first:1539.86 08:23:00 INFO - PID 27000 | Values: 577.6 582.6 590.1 596.2 616.4 6276.2 6302.6 6339.9 6382.7 6431.7 6209.1 6246.7 6257.7 6278.7 6279.8 5133.2 5169.4 5174.8 5181.2 5181.8 4926.3 5148.3 5163.6 5170.8 5200.5 4982.7 4986.0 5016.2 5031.3 5047.2 4975.0 4977.5 5020.8 5028.5 5048.1 4504.8 4543.1 4580.8 4584.5 4593.6 6178.9 6204.6 6240.0 6245.6 6253.9 5943.2 5995.6 6005.5 6006.2 6023.5 6629.5 6646.9 6657.8 6708.9 6725.5 5059.0 5082.7 5152.7 5154.1 5188.2 6730.0 6840.7 6890.2 6975.8 6982.3 5234.4 5249.3 5264.8 5321.1 5351.0 5302.9 5372.9 5377.2 5380.3 5424.6 5864.1 5957.0 5960.1 5987.5 6010.6 6728.4 6779.0 6787.0 6792.3 6813.4 1830.4 1834.3 1851.1 1867.7 1869.2 1287.9 1310.1 1317.2 1336.4 1336.4 6221.0 6265.7 6343.5 6389.6 6409.6 6759.5 6764.9 6769.8 6840.1 6861.7 6308.9 6369.5 6404.9 6417.7 6435.8 3549.4 3570.7 3586.8 3598.7 3604.3 7109.2 7132.0 7147.7 7167.8 7176.5 6947.7 6953.7 7001.2 7017.0 7088.0 6964.0 7002.4 7016.5 7020.3 7035.8 6706.6 6752.8 6754.1 6792.9 6832.4 6691.6 6724.8 6760.0 6780.7 6806.9 6981.9 6998.0 7017.8 7082.1 7226.9 5243.2 5312.6 5314.7 5315.2 5322.9 6526.5 6573.4 6740.9 6813.6 6834.6 6488.9 6583.0 6606.8 6660.5 6690.6 6569.2 6582.7 6605.6 6643.9 6673.5 6310.3 6495.8 6540.3 6582.1 6619.2 6628.5 6692.8 6707.2 6732.1 6746.4 6468.6 6520.3 6572.9 6591.4 6592.5 08:23:00 INFO - PID 27000 | 08:23:00 INFO - PID 27000 | [#5] yui.html Cycles:180 Average:29504.21 Median:19874.11 stddev:43729.77 (220.0%) stddev-sans-first:43799.70 08:23:00 INFO - PID 27000 | Values: 897.9 923.2 939.1 998.0 1031.0 20825.0 21628.2 21629.9 21783.0 21802.7 19584.0 19715.6 19717.4 19743.3 19961.0 1085.3 1088.5 1088.8 1089.1 1089.8 1056.9 1083.9 1089.4 1091.4 1093.6 1170.4 1171.8 1172.9 1173.6 1177.4 1154.6 1156.9 1157.5 1159.9 1165.8 854.3 855.9 857.1 864.0 865.6 20837.9 20975.2 21158.8 21178.3 21735.6 20384.9 20442.0 20710.2 20742.8 20750.5 17927.6 17987.4 18060.7 18131.0 18214.3 4002.9 4012.9 4025.7 4045.5 4054.8 147462.0 158641.0 161482.0 161771.0 168735.0 18659.3 19411.6 19413.7 19430.5 19432.6 31143.4 31971.0 32112.5 32323.7 32339.5 9533.3 9534.7 9584.0 9588.6 9590.5 4752.9 4802.4 4814.3 4817.0 4825.0 6422.9 6423.8 6465.5 6493.6 6523.9 1257.8 1273.7 1279.0 1289.6 1294.1 768.4 776.6 782.2 796.1 807.3 12738.0 12877.9 13632.9 13833.2 13851.8 759.4 763.2 763.4 766.4 777.1 6023.8 6149.9 6186.5 6211.9 6216.5 155604.2 156393.0 158327.0 159151.0 160797.0 112022.9 124621.0 142694.0 143515.3 143564.0 119162.0 122586.4 123454.0 126075.4 127107.4 13889.4 14115.4 14191.6 14200.7 14320.1 58475.4 58679.4 58982.7 60056.0 60473.0 75792.2 77555.0 77711.7 78262.0 78681.6 19214.7 19220.7 19757.6 19872.2 20168.5 19672.6 19808.8 20027.5 20106.9 20356.4 20087.0 20276.3 20372.7 20410.5 20530.6 19492.9 19521.3 19718.4 19827.6 19876.0 19864.4 19963.3 20025.5 20039.9 20121.1 15108.5 15494.6 15544.8 15581.6 15609.9 15062.2 15312.5 15377.2 15478.2 15643.7 08:23:00 INFO - PID 27000 | -------- Summary: end -------- 08:23:00 INFO - PID 27000 | 08:23:00 INFO - TEST-INFO | 27000: exit 0 08:23:01 INFO - TEST-OK | dromaeo_css | took 1107635ms 08:23:01 INFO - TEST-START | kraken 08:23:01 INFO - Initialising browser for kraken test... 08:23:01 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:60793/getInfo.html -profile /tmp/tmpYAXpMn/profile 08:23:01 INFO - TEST-INFO | started process 27369 (/builds/slave/test/build/application/firefox/firefox http://localhost:60793/getInfo.html) 08:23:06 INFO - TEST-INFO | 27369: exit 0 08:23:06 INFO - Browser initialized. 08:23:06 INFO - Running cycle 1/1 for kraken test... 08:23:06 INFO - Using env: {'DISPLAY': ':0', 08:23:06 INFO - 'HOME': '/home/cltbld', 08:23:06 INFO - 'JSGC_DISABLE_POISONING': '1', 08:23:06 INFO - 'LANG': 'en_US.UTF-8', 08:23:06 INFO - 'LANGUAGE': 'en_US:en', 08:23:06 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 08:23:06 INFO - 'LOGNAME': 'cltbld', 08:23:06 INFO - 'MAIL': '/var/mail/cltbld', 08:23:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:23:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:23:06 INFO - 'MOZ_CRASHREPORTER': '1', 08:23:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:06 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 08:23:06 INFO - 'MOZ_NO_REMOTE': '1', 08:23:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:23:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:06 INFO - 'NO_EM_RESTART': '1', 08:23:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:06 INFO - 'PWD': '/builds/slave/test', 08:23:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:23:06 INFO - 'RUST_BACKTRACE': 'full', 08:23:06 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 08:23:06 INFO - 'SHELL': '/bin/bash', 08:23:06 INFO - 'SHLVL': '1', 08:23:06 INFO - 'TERM': 'linux', 08:23:06 INFO - 'TMOUT': '86400', 08:23:06 INFO - 'USER': 'cltbld', 08:23:06 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1506351790.807965-1201926482', 08:23:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:06 INFO - '_': '/tools/buildbot/bin/python'} 08:23:06 INFO - TEST-INFO | started process 27563 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYAXpMn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 08:23:07 INFO - PID 27563 | 08:23:07 INFO - PID 27563 | (/builds/slave/test/build/application/firefox/firefox:27612): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 08:23:07 INFO - PID 27563 | 08:23:17 INFO - PID 27563 | RSS: Main: 141307904 08:23:17 INFO - PID 27563 | 08:23:20 INFO - PID 27563 | Cycle 1(1): loaded http://localhost:60793/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60793/tests/kraken/driver.html?testName=audio-beat-detection) 08:23:21 INFO - PID 27563 | RSS: Main: 148090880 08:23:21 INFO - PID 27563 | 08:23:23 INFO - PID 27563 | Cycle 1(1): loaded http://localhost:60793/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60793/tests/kraken/driver.html?testName=audio-dft) 08:23:24 INFO - PID 27563 | RSS: Main: 148111360 08:23:24 INFO - PID 27563 | 08:23:27 INFO - PID 27563 | Cycle 1(1): loaded http://localhost:60793/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60793/tests/kraken/driver.html?testName=audio-fft) 08:23:27 INFO - PID 27563 | RSS: Main: 149725184 08:23:27 INFO - PID 27563 | 08:23:29 INFO - PID 27563 | Cycle 1(1): loaded http://localhost:60793/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60793/tests/kraken/driver.html?testName=audio-oscillator) 08:23:30 INFO - PID 27563 | RSS: Main: 150052864 08:23:30 INFO - PID 27563 | 08:23:32 INFO - PID 27563 | Cycle 1(1): loaded http://localhost:60793/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60793/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:23:33 INFO - PID 27563 | RSS: Main: 149688320 08:23:33 INFO - PID 27563 | 08:23:36 INFO - PID 27563 | Cycle 1(1): loaded http://localhost:60793/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60793/tests/kraken/driver.html?testName=imaging-darkroom) 08:23:36 INFO - PID 27563 | RSS: Main: 149741568 08:23:36 INFO - PID 27563 | 08:23:40 INFO - PID 27563 | Cycle 1(1): loaded http://localhost:60793/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60793/tests/kraken/driver.html?testName=imaging-desaturate) 08:23:40 INFO - PID 27563 | RSS: Main: 150347776 08:23:40 INFO - PID 27563 | 08:23:43 INFO - PID 27563 | Cycle 1(1): loaded http://localhost:60793/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60793/tests/kraken/driver.html?testName=json-parse-financial) 08:23:44 INFO - PID 27563 | RSS: Main: 151879680 08:23:44 INFO - PID 27563 | 08:23:45 INFO - PID 27563 | Cycle 1(1): loaded http://localhost:60793/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60793/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:23:46 INFO - PID 27563 | RSS: Main: 152076288 08:23:46 INFO - PID 27563 | 08:23:47 INFO - PID 27563 | Cycle 1(1): loaded http://localhost:60793/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60793/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:23:48 INFO - PID 27563 | RSS: Main: 152084480 08:23:48 INFO - PID 27563 | 08:23:50 INFO - PID 27563 | Cycle 1(1): loaded http://localhost:60793/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60793/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:23:51 INFO - PID 27563 | RSS: Main: 149073920 08:23:51 INFO - PID 27563 | 08:23:53 INFO - PID 27563 | Cycle 1(1): loaded http://localhost:60793/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60793/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:23:54 INFO - PID 27563 | RSS: Main: 149164032 08:23:54 INFO - PID 27563 | 08:23:56 INFO - PID 27563 | Cycle 1(1): loaded http://localhost:60793/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60793/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:23:57 INFO - PID 27563 | RSS: Main: 149823488 08:23:57 INFO - PID 27563 | 08:23:59 INFO - PID 27563 | Cycle 1(1): loaded http://localhost:60793/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60793/tests/kraken/driver.html?testName=ai-astar) 08:23:59 INFO - PID 27563 | RSS: Main: 150982656 08:23:59 INFO - PID 27563 | 08:23:59 INFO - PID 27563 | __start_tp_report 08:23:59 INFO - PID 27563 | _x_x_mozilla_page_load 08:23:59 INFO - PID 27563 | _x_x_mozilla_page_load_details 08:23:59 INFO - PID 27563 | |i|pagename|runs| 08:23:59 INFO - PID 27563 | |0;ai-astar;106;105;105;105;106;110;105;105;105;108 08:23:59 INFO - PID 27563 | |1;audio-beat-detection;117;111;110;116;112;117;110;112;111;141 08:23:59 INFO - PID 27563 | |2;audio-dft;160;163;162;164;161;161;162;164;162;162 08:23:59 INFO - PID 27563 | |3;audio-fft;74;73;74;74;73;73;73;71;73;74 08:23:59 INFO - PID 27563 | |4;audio-oscillator;78;78;78;81;76;77;77;77;79;78 08:23:59 INFO - PID 27563 | |5;imaging-gaussian-blur;117;113;117;116;114;113;113;114;113;116 08:23:59 INFO - PID 27563 | |6;imaging-darkroom;148;150;148;151;150;150;147;148;149;149 08:23:59 INFO - PID 27563 | |7;imaging-desaturate;99;94;95;94;95;94;93;94;94;101 08:23:59 INFO - PID 27563 | |8;json-parse-financial;47;43;46;43;50;44;48;45;44;44 08:23:59 INFO - PID 27563 | |9;json-stringify-tinderbox;38;39;38;40;39;39;40;40;39;39 08:23:59 INFO - PID 27563 | |10;stanford-crypto-aes;71;72;73;72;82;75;69;74;71;74 08:23:59 INFO - PID 27563 | |11;stanford-crypto-ccm;113;102;105;105;105;103;105;109;102;109 08:23:59 INFO - PID 27563 | |12;stanford-crypto-pbkdf2;153;152;153;156;154;157;157;154;157;159 08:23:59 INFO - PID 27563 | |13;stanford-crypto-sha256-iterative;64;60;60;59;61;62;59;59;59;58 08:23:59 INFO - PID 27563 | __end_tp_report 08:23:59 INFO - PID 27563 | __start_cc_report 08:23:59 INFO - PID 27563 | _x_x_mozilla_cycle_collect,667 08:23:59 INFO - PID 27563 | __end_cc_report 08:23:59 INFO - PID 27563 | __startTimestamp1506353039290__endTimestamp 08:23:59 INFO - PID 27563 | 08:23:59 INFO - PID 27563 | ------- Summary: start ------- 08:23:59 INFO - PID 27563 | Number of tests: 14 08:23:59 INFO - PID 27563 | 08:23:59 INFO - PID 27563 | [#0] ai-astar Cycles:10 Average:106.00 Median:105.50 stddev:1.70 (1.6%) stddev-sans-first:1.80 08:23:59 INFO - PID 27563 | Values: 106.0 105.0 105.0 105.0 106.0 110.0 105.0 105.0 105.0 108.0 08:23:59 INFO - PID 27563 | 08:23:59 INFO - PID 27563 | [#1] audio-beat-detection Cycles:10 Average:115.70 Median:114.00 stddev:9.31 (8.2%) stddev-sans-first:9.86 08:23:59 INFO - PID 27563 | Values: 117.0 111.0 110.0 116.0 112.0 117.0 110.0 112.0 111.0 141.0 08:23:59 INFO - PID 27563 | 08:23:59 INFO - PID 27563 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.00 stddev:1.29 (0.8%) stddev-sans-first:1.12 08:23:59 INFO - PID 27563 | Values: 160.0 163.0 162.0 164.0 161.0 161.0 162.0 164.0 162.0 162.0 08:23:59 INFO - PID 27563 | 08:23:59 INFO - PID 27563 | [#3] audio-fft Cycles:10 Average:73.20 Median:73.50 stddev:0.92 (1.3%) stddev-sans-first:0.93 08:23:59 INFO - PID 27563 | Values: 74.0 73.0 74.0 74.0 73.0 73.0 73.0 71.0 73.0 74.0 08:23:59 INFO - PID 27563 | 08:23:59 INFO - PID 27563 | [#4] audio-oscillator Cycles:10 Average:77.90 Median:78.00 stddev:1.37 (1.8%) stddev-sans-first:1.45 08:23:59 INFO - PID 27563 | Values: 78.0 78.0 78.0 81.0 76.0 77.0 77.0 77.0 79.0 78.0 08:23:59 INFO - PID 27563 | 08:23:59 INFO - PID 27563 | [#5] imaging-gaussian-blur Cycles:10 Average:114.60 Median:115.00 stddev:1.71 (1.5%) stddev-sans-first:1.58 08:23:59 INFO - PID 27563 | Values: 117.0 113.0 117.0 116.0 114.0 113.0 113.0 114.0 113.0 116.0 08:23:59 INFO - PID 27563 | 08:23:59 INFO - PID 27563 | [#6] imaging-darkroom Cycles:10 Average:149.00 Median:149.50 stddev:1.25 (0.8%) stddev-sans-first:1.27 08:23:59 INFO - PID 27563 | Values: 148.0 150.0 148.0 151.0 150.0 150.0 147.0 148.0 149.0 149.0 08:23:59 INFO - PID 27563 | 08:23:59 INFO - PID 27563 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:94.00 stddev:2.58 (2.7%) stddev-sans-first:2.37 08:23:59 INFO - PID 27563 | Values: 99.0 94.0 95.0 94.0 95.0 94.0 93.0 94.0 94.0 101.0 08:23:59 INFO - PID 27563 | 08:23:59 INFO - PID 27563 | [#8] json-parse-financial Cycles:10 Average:45.40 Median:45.50 stddev:2.32 (5.1%) stddev-sans-first:2.39 08:23:59 INFO - PID 27563 | Values: 47.0 43.0 46.0 43.0 50.0 44.0 48.0 45.0 44.0 44.0 08:23:59 INFO - PID 27563 | 08:23:59 INFO - PID 27563 | [#9] json-stringify-tinderbox Cycles:10 Average:39.10 Median:39.00 stddev:0.74 (1.9%) stddev-sans-first:0.67 08:23:59 INFO - PID 27563 | Values: 38.0 39.0 38.0 40.0 39.0 39.0 40.0 40.0 39.0 39.0 08:23:59 INFO - PID 27563 | 08:23:59 INFO - PID 27563 | [#10] stanford-crypto-aes Cycles:10 Average:73.30 Median:73.50 stddev:3.53 (4.8%) stddev-sans-first:3.64 08:23:59 INFO - PID 27563 | Values: 71.0 72.0 73.0 72.0 82.0 75.0 69.0 74.0 71.0 74.0 08:23:59 INFO - PID 27563 | 08:23:59 INFO - PID 27563 | [#11] stanford-crypto-ccm Cycles:10 Average:105.80 Median:105.00 stddev:3.52 (3.4%) stddev-sans-first:2.60 08:23:59 INFO - PID 27563 | Values: 113.0 102.0 105.0 105.0 105.0 103.0 105.0 109.0 102.0 109.0 08:23:59 INFO - PID 27563 | 08:23:59 INFO - PID 27563 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.20 Median:156.50 stddev:2.30 (1.5%) stddev-sans-first:2.30 08:23:59 INFO - PID 27563 | Values: 153.0 152.0 153.0 156.0 154.0 157.0 157.0 154.0 157.0 159.0 08:23:59 INFO - PID 27563 | 08:23:59 INFO - PID 27563 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.10 Median:60.00 stddev:1.79 (3.0%) stddev-sans-first:1.22 08:23:59 INFO - PID 27563 | Values: 64.0 60.0 60.0 59.0 61.0 62.0 59.0 59.0 59.0 58.0 08:23:59 INFO - PID 27563 | -------- Summary: end -------- 08:23:59 INFO - PID 27563 | 08:23:59 INFO - PID 27563 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 08:23:59 INFO - TEST-INFO | 27563: exit 0 08:24:00 INFO - TEST-OK | kraken | took 59016ms 08:24:00 INFO - SUITE-END | took 1166s 08:24:00 INFO - Completed test suite (00:19:27) 08:24:00 INFO - javascript benchmark 08:24:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9453.987405424532, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [4028.274910516107, 4034.5360283567397, 4037.4145748866417, 4057.0871553900392, 4057.939130913037, 6416.037594360848, 6453.064305675674, 6456.451201647854, 6566.080748695186, 6581.506387020974, 6471.223453185625, 6489.0, 6504.73981040759, 6562.606243625386, 6586.901196482045, 5778.219940308047, 5799.507041901444, 5805.622634528763, 5832.6792026438525, 5843.5033022193165, 5727.11229759388, 5795.1886735857015, 5804.709764511778, 5807.767689292423, 5909.0250108732225, 5777.42225777421, 5783.0, 5832.912506312408, 5839.7664093436215, 5904.409559044083, 5794.159846822229, 5880.0, 5930.614510056854, 5948.137520059568, 5965.61223520472, 5681.375048744635, 5744.138379243105, 5780.132980052984, 5813.88372232553, 5978.55160862937, 6331.715072821688, 6376.649284289362, 6385.850546901556, 6410.8076757697345, 6476.90284645726, 6990.6155161466095, 7029.789106326818, 7049.859002819915, 7121.786346409616, 7133.144022717255, 7020.824479388005, 7073.787786366417, 7077.2568880267345, 7137.2149063602965, 7154.35610795031, 6596.373344532358, 6612.603243805387, 6641.933580664228, 6647.900281495733, 6654.367835055662, 7220.783376498714, 7236.565806051653, 7245.8550828983125, 7340.926590734024, 7354.963225183947, 6811.352921472452, 6927.376536111673, 6952.617606031616, 6957.860842783116, 7044.542104763174, 7055.294470553006, 7078.539894906815, 7078.893816592756, 7087.078679771596, 7169.605671688108, 6936.167659880846, 6943.618101004493, 7059.294070593002, 7087.0432491614, 7135.357817796424, 6949.687264073129, 7046.295370462913, 7059.717611295593, 7072.222055573883, 7136.0723105995885, 5099.107656160157, 5111.795528178905, 5119.078565858107, 5149.588032957355, 5164.147915593885, 4763.476017638057, 4827.927581086286, 4830.203016502238, 4834.347363106006, 4858.878528036827, 6635.635040072746, 6726.428253598499, 6781.321867813278, 6804.4216241620015, 6810.897836532456, 7096.964515177391, 7110.1112360954885, 7184.892226616605, 7185.856282874313, 7195.316444937723, 6584.407403333723, 6682.465402767767, 6689.665516724242, 6690.464762818963, 6721.66391680414, 5889.734961926723, 5962.522998160137, 5968.432998865101, 5971.5222782177325, 5972.731227094791, 7281.4538909582, 7305.293712632698, 7308.37878780299, 7480.326770590673, 7488.438367122379, 7115.075040244735, 7141.285871413025, 7170.713171473083, 7185.604791736505, 7201.747938822116, 7452.627368631655, 7460.465208886092, 7470.626468676436, 7519.661615227218, 7570.091589009354, 6944.583325000516, 6999.965000175171, 7003.789886303419, 7087.291270872872, 7145.1068616422945, 7121.82195445118, 7132.1441427029085, 7138.321859423347, 7152.9284707152265, 7171.641417929187, 6812.931870681428, 6819.488538359544, 6843.726250950105, 6910.44716422695, 6915.585064896122, 6774.796756097325, 6791.592504449749, 6811.455083593201, 6875.1749790025515, 6885.380315771605, 6669.333066693292, 6778.3221677831825, 6780.118584583973, 6805.489588280998, 6836.0, 6720.0, 6944.4097251734165, 6969.128858892638, 6969.233384327821, 7020.438364930896, 6633.834154146185, 6640.800775976729, 6676.49926255523, 6737.29258427858, 6739.6967136478], "value": 6479.756195821031, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [930.4510338900047, 968.6319198704491, 983.7983213441245, 1030.7217051396124, 1037.559037409101, 45299.77350113249, 46231.537684623145, 46239.53760462395, 46244.306335404995, 46351.0, 43710.344344834775, 43847.780761096226, 43879.561204387945, 43882.780586097106, 43985.0, 8204.507729536217, 8283.544405057719, 8295.294899933513, 8318.209770071864, 8326.958365208166, 7928.722494712686, 7964.482308649919, 7972.282494575487, 7992.120866704658, 8163.714270000552, 8334.083250842403, 8382.748517544484, 8384.958075209615, 8433.114522975091, 8449.619767110464, 8241.670333186696, 8331.33349332052, 8340.249377556018, 8365.665373385058, 8404.663813447454, 8812.16284452976, 8832.33757468186, 8917.509536975464, 8920.910790892072, 8954.910450895539, 42143.1571368574, 42515.787421063, 42536.78731606322, 42817.0, 42824.78587607042, 3848.5189351331082, 3849.480320156771, 3879.8448062077764, 3881.3013657541633, 3893.8637147699696, 34781.82609086964, 34909.650903490896, 35049.299014019576, 35082.649173508195, 35085.47371789425, 5432.75552600134, 5465.152901300305, 5467.097928841737, 5511.53151982082, 5521.309836270466, 238239.0, 238563.0, 238850.0, 239498.99999999825, 239772.0, 55321.44678553243, 55336.72331638316, 55380.72309638507, 55393.0, 55506.444935550935, 57671.0, 58036.70981645149, 58126.0, 58146.22049566764, 58222.0, 18851.622967540574, 19009.334673286645, 19009.714854277197, 19017.429477115707, 19034.904825475784, 15538.300776465087, 15547.84452155464, 15601.141937193337, 15603.843961560238, 15609.687806243812, 15309.846901530842, 15327.0, 15397.692046159014, 15400.768988465183, 15542.844571554366, 5819.883602328015, 5831.737571809279, 5875.676837773964, 5928.555358348141, 5936.0, 1081.1620993729923, 1111.9214362068942, 1120.2326406411635, 1120.9327440353604, 1121.1943502937256, 26968.190954271402, 27294.863525682245, 27421.451570968467, 27614.861925690242, 27687.0, 1216.555957075661, 1221.2001139253803, 1225.6489462408415, 1238.6717519857245, 1243.6704273367566, 13978.0, 14156.36296366666, 14204.360803763855, 14468.493602724066, 14621.415143394144, 319521.0, 322452.0, 323457.0, 323758.0, 324463.0, 54407.0, 55158.0, 55381.446185538436, 63237.36762632407, 63407.6829615849, 1509.7131545006632, 1540.9383624654888, 1547.2263868066193, 1554.0830909763295, 1558.2442515380258, 33120.0, 33434.832825835714, 33464.665353347125, 33550.0, 33908.321833563685, 41974.0, 42989.35515967326, 43322.78338608287, 43339.0, 43379.566204337556, 237756.0, 238029.0, 238561.0, 239528.0, 240400.0, 38178.618213817506, 38349.808250959686, 38481.42277865778, 38854.0, 38923.416148758355, 50639.0, 51880.74059629829, 52029.479705202466, 52084.47915520796, 52203.47796521986, 37211.6278837219, 37336.813315934334, 37408.43887341637, 37449.81275093607, 37532.81233593814, 36785.26429471449, 37224.81387593153, 37233.25533489261, 37301.4404783923, 37359.0, 42616.57383426126, 44178.55821441873, 44232.0, 44380.11239775251, 44675.77662111669, 34716.47925281173, 35417.645823542465, 35518.644813552564, 35710.42895710408, 36230.0, 26576.7342326582, 26596.0, 26881.731182687923, 27207.183784486497, 27446.394931066417], "value": 19605.87332806016, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [631.141762305106, 636.2672322375397, 637.7247688611711, 648.0887792848335, 656.791503633315, 23981.76018239817, 24443.144489942857, 24587.139450119248, 24685.75314246857, 24832.255032349058, 25967.22098337048, 26211.47577048458, 26363.20910372687, 26382.20853374397, 26445.86777066112, 6666.166729158843, 6940.2712715164935, 6944.0, 6945.930540694604, 6968.372846443819, 6904.75833345833, 6955.374016338528, 6962.512624116314, 6965.721371145148, 6966.268541803113, 6916.930830691704, 6920.307969203064, 6921.273266307016, 6922.861542769142, 6937.583744975293, 6835.829104272383, 6913.75801846933, 6925.688344024531, 6930.653467326639, 6949.096617439725, 6410.0705397717065, 6428.035794630796, 6450.129232553592, 6471.579347342407, 6496.9675151624415, 31622.683773162204, 32188.356232875445, 32214.0, 32294.515582266285, 32351.191220219447, 2390.7250666173263, 2391.9521609567887, 2420.1529464687396, 2422.6608274841537, 2427.757224277576, 20838.5832283355, 21132.788672113234, 21617.67573486399, 22375.440613984618, 22484.550308993894, 2642.8017898657486, 2647.7219891911263, 2683.9329016774736, 2684.3020814588153, 2696.649435573363, 136837.0, 144234.0, 168657.0, 174102.0, 175357.0, 17116.229769660396, 17371.218295176746, 17721.379751708628, 17919.259613850307, 17994.730079048826, 27173.456530869273, 27249.727502725116, 27442.862785685942, 27448.17655470339, 27448.588271175948, 11858.525658973716, 11963.58127465552, 12023.458944347525, 12158.562124824552, 12164.56708658272, 11215.439228038565, 11236.0, 11256.662300131009, 11269.605563805391, 11306.0, 10584.153267738562, 10674.519646615921, 10699.25105242641, 10728.94635526833, 10792.46037698112, 2866.4553734790325, 2916.1688918658506, 2973.9702602974126, 3002.639683237982, 3115.501519756828, 1059.2743970380313, 1060.9840852387065, 1066.6746642274027, 1070.796548655753, 1086.6468397770757, 21330.253441129797, 21832.0, 22006.0, 22193.44516387103, 22415.66376504321, 1148.7771162800009, 1151.0848875144281, 1156.2657712352548, 1158.478684591937, 1162.8372027916098, 11794.587189448328, 11905.98799102086, 12002.239484918344, 12063.914247717572, 12345.753084938251, 716635.0, 718180.0, 730422.0, 732748.0, 748612.0, 136604.31697841448, 137554.0, 140923.0, 141028.0, 141097.29451352678, 1272.993635031819, 1278.1883503975043, 1292.6251387097825, 1293.0625296659846, 1296.4490091710986, 18843.717344239572, 19093.0, 19118.139683714544, 19134.904325478285, 19226.519337016685, 62090.37909620846, 62311.0, 62484.0, 63654.68172659107, 65172.348276516626, 82814.0, 83109.58445207735, 83648.58175709083, 83683.16316836997, 84496.0, 16258.430954916521, 16428.42500512476, 16483.093429861474, 16534.0, 16594.087325196746, 24718.382040449134, 24760.628590570795, 24825.751742483066, 24880.12919547807, 25158.119465818607, 19980.3006894758, 20450.0, 20523.384298471068, 20607.0, 20626.0, 17479.038652873704, 17869.821301786815, 17960.281588736303, 18254.72617910759, 18463.630727385647, 20529.486762830453, 20544.972751362075, 20657.17371305131, 20791.0, 20878.060487277806, 15834.841651583798, 16003.839961600701, 16019.839801601835, 16035.438759643357, 16113.0, 17198.0, 17399.0, 19861.702074468605, 20203.79796202019, 20354.694679580116], "value": 13395.869725372844, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1444.8410674825768, 1485.9331330090145, 1499.4452052740487, 1524.969500609987, 1533.0724911428586, 17041.744373834386, 17666.734998975026, 17774.822251777478, 17775.28898844046, 17787.82212177878, 17303.39438119666, 17485.125743712826, 17490.0, 17497.825021749777, 17500.56248593786, 3104.518799586068, 3123.437781199383, 3158.44727172745, 3171.2389026633673, 3179.554862319277, 3055.648600410948, 3079.55346474761, 3090.8300043497597, 3093.6596974332806, 3095.272610936428, 3000.834954077525, 3039.1642298368015, 3065.417570661567, 3165.1612322734495, 3166.509191075387, 3104.720575148236, 3109.67348428414, 3138.968610313902, 3145.5753473281156, 3153.180173154973, 2996.475616767057, 3058.9847050764824, 3073.1702440340982, 3087.706667866549, 3091.48990416581, 16849.91575042117, 17227.483175504756, 17327.826721732872, 17354.826451735447, 17372.47882563525, 9156.404833685789, 9452.57463414148, 9463.763405914839, 9480.194183494412, 9481.47851868147, 5632.971835140839, 5643.774249030034, 6012.909806352908, 6030.09548567714, 6043.153958445821, 2057.444489987695, 2060.5054786851197, 2075.2632815350635, 2109.4199095248778, 2142.0, 30971.915982940714, 31009.0, 31082.0, 31182.0, 31190.532142017888, 7485.700571977169, 7709.113451953097, 7850.6859725611475, 7868.724594639275, 7978.122406535276, 20530.38408847737, 20589.38231853047, 20616.175352985712, 20739.896300518703, 20756.169753210004, 8608.569571521399, 8795.868061979076, 8796.692115775917, 8810.77973050666, 8821.161989610977, 8055.919440805634, 8090.312323452455, 8291.33669306454, 8497.74506764798, 8524.914750852537, 5985.910211346833, 6229.906337404333, 6252.437280644764, 6252.968735156295, 6373.330800265905, 1706.709859323918, 1749.422690512128, 1761.5948331883737, 1778.3509019207895, 1805.7742782152231, 830.2610676497922, 985.1970643925179, 1019.8164330420448, 1023.2581378500677, 1035.3270374256792, 9602.84765828091, 9613.471259080678, 9827.4103553787, 9865.605375784888, 10013.29906906524, 824.8556502612139, 827.8634025385744, 839.630562552475, 853.5220276645099, 910.0717268386209, 6244.562880598314, 6283.120363149163, 6403.903941440882, 6528.151340325728, 6557.836054098686, 25039.0, 26452.338691532867, 26754.5986810198, 27012.594811077848, 27069.052583159493, 26429.603555946676, 26730.930762769272, 26984.730152698616, 27341.769620367133, 27571.31071723223, 12356.196847205083, 12510.249385036926, 12556.497740090294, 12587.62237132869, 12599.307038112991, 9945.353552019096, 10033.347832390871, 10233.283670143317, 10359.896401035892, 10441.791164176522, 22447.21434749776, 22680.319590412313, 22867.0, 22926.312210633707, 22938.770612293665, 23685.17101901425, 23728.644070339305, 23872.28383148508, 24082.51834963326, 24409.26772196837, 12937.805932911202, 13012.349382530647, 13148.211107333591, 13158.0, 13162.078654494477, 16089.919550402174, 16376.099314537814, 16523.917380413022, 16531.752023719895, 16596.419125330554, 12549.372531373578, 12987.0, 13041.739165216453, 13371.465141394625, 13416.32918354098, 12333.383330833243, 12432.005439564993, 12474.750504989668, 12676.0, 12820.23078615286, 10685.412302323446, 10717.732056698645, 10792.514336855018, 10855.945720271347, 10880.727981800519, 8083.110857805755, 8100.554469504234, 8138.83722325562, 8139.232660895324, 8151.714689985822, 8473.0, 8474.898263225741, 8533.643683820474, 8567.571621419029, 8576.313894888519], "value": 7671.420801900023, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.5581680014786, 582.6242073862359, 590.1030433740714, 596.1504855580796, 616.4298024327496, 6276.184096067511, 6302.621842689437, 6339.936600633992, 6382.702227198205, 6431.678416079189, 6209.130721698965, 6246.687665616723, 6257.71840267188, 6278.68606569672, 6279.843003924904, 5133.204353325241, 5169.40551836538, 5174.844754657366, 5181.222816577525, 5181.844544663666, 4926.261060840867, 5148.253503242027, 5163.586913046947, 5170.793168273283, 5200.505951934579, 4982.676126051795, 4986.0, 5016.247562865581, 5031.345925029741, 5047.242913562976, 4974.950250497485, 4977.452480227172, 5020.824271150511, 5028.522290382408, 5048.066107770074, 4504.842330518416, 4543.091381723669, 4580.7938642761155, 4584.472785629662, 4593.63250939924, 6178.938210617881, 6204.565680402374, 6240.001599744064, 6245.5628106032145, 6253.873682947774, 5943.227380440515, 5995.550333724988, 6005.519558435315, 6006.159137720722, 6023.518118550549, 6629.547067585025, 6646.933530664728, 6657.76697815579, 6708.865822683519, 6725.461963042945, 5058.974705126488, 5082.695038297714, 5152.742362881841, 5154.12379895415, 5188.221766734982, 6729.966350168267, 6840.726370945156, 6890.1731792184755, 6975.790726278169, 6982.26686197952, 5234.42421333653, 5249.265102885599, 5264.763085661154, 5321.09541377959, 5351.0, 5302.878848460647, 5372.8656783579945, 5377.193420986805, 5380.300560927054, 5424.593155513273, 5864.149698293723, 5957.017092179742, 5960.1059841023325, 5987.461128498456, 6010.557466208079, 6728.400305836354, 6779.0, 6787.0, 6792.320767923168, 6813.420859226922, 1830.432565904574, 1834.2937968882077, 1851.0837135617955, 1867.71984202368, 1869.1962456143988, 1287.8840904318656, 1310.0960337367187, 1317.2228385252747, 1336.3719052045524, 1336.432016393029, 6220.968895155585, 6265.655388953652, 6343.524235682342, 6389.552731308764, 6409.615423074631, 6759.493038022168, 6764.932350676529, 6769.796906092825, 6840.144981877265, 6861.696277707219, 6308.936910630927, 6369.484053798724, 6404.903926441107, 6417.74329026843, 6435.839104022437, 3549.396602577568, 3570.732195085379, 3586.8206589670413, 3598.7300952428673, 3604.2611264690677, 7109.1824440189, 7132.0, 7147.749828755968, 7167.820804479929, 7176.497645164788, 6947.652617369111, 6953.652317384111, 7001.159860816632, 7017.0, 7087.964560177166, 6964.015255652115, 7002.40479559233, 7016.509139255593, 7020.333068358498, 7035.8286659306395, 6706.631135287606, 6752.831179220559, 6754.142610782074, 6792.93207067923, 6832.350926662158, 6691.59850408977, 6724.831879203059, 6759.966200168968, 6780.694868731018, 6806.897896531655, 6981.930180698128, 6997.96501017512, 7017.824554386181, 7082.114735658043, 7226.855462890608, 5243.239730239017, 5312.62811603184, 5314.681119132864, 5315.229291752751, 5322.866928326823, 6526.510511711545, 6573.375529324707, 6740.921452567762, 6813.557118787263, 6834.589924604539, 6488.935110648833, 6582.967085164543, 6606.8017959461295, 6660.467162627075, 6690.591387100542, 6569.178852643419, 6582.703778329891, 6605.636689982097, 6643.867122657616, 6673.499487538357, 6310.305866354789, 6495.823898993701, 6540.313267107075, 6582.1443212384, 6619.172603424572, 6628.502862285444, 6692.765753198614, 6707.195136583446, 6732.057511948233, 6746.4265537429865, 6468.611883287018, 6520.282768895512, 6572.868542629025, 6591.406773390418, 6592.505562082767], "value": 5254.016994827018, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [897.8877640294963, 923.2475532441056, 939.0843927171005, 997.9770734996628, 1031.0411317474748, 20825.0, 21628.2430114946, 21629.891850540746, 21783.0, 21802.672959905613, 19584.0, 19715.605687886233, 19717.35228982639, 19743.308984185558, 19961.0, 1085.2620218251586, 1088.521050737677, 1088.7768007558432, 1089.1069323155016, 1089.7874914391696, 1056.878458977216, 1083.864516935383, 1089.3953855610134, 1091.4488183467377, 1093.606301731376, 1170.3563040327829, 1171.800793865045, 1172.8827117288288, 1173.6185739634611, 1177.370106992759, 1154.59589143799, 1156.8727439981594, 1157.5196293538213, 1159.9246049006829, 1165.8192980088015, 854.3378881366929, 855.9186877246714, 857.1428571428571, 863.952482613456, 865.6277800545763, 20837.89581052085, 20975.16099356024, 21158.788412115835, 21178.25876094345, 21735.565288694295, 20384.898075509675, 20442.0, 20710.17159313641, 20742.792572074388, 20750.48123796902, 17927.551811204692, 17987.370442034466, 18060.729089063676, 18131.0, 18214.27142914282, 4002.899927501807, 4012.879613611596, 4025.698072644534, 4045.5145382553987, 4054.837806487737, 147462.0, 158641.0, 161482.0, 161771.0, 168735.0, 18659.346922857636, 19411.611767764567, 19413.708794368096, 19430.514237144183, 19432.611347772967, 31143.377132457677, 31971.0, 32112.518312225337, 32323.676763232535, 32339.51490727641, 9533.332666713402, 9534.713958581253, 9584.041595840361, 9588.616455341707, 9590.472524011246, 4752.928706069411, 4802.423709154924, 4814.253790662453, 4816.95183048165, 4825.034993001414, 6422.903656445157, 6423.807285781434, 6465.547411681231, 6493.577917435352, 6523.902141467882, 1257.798752199662, 1273.7452509498137, 1279.0087682046303, 1289.6389011076913, 1294.0876681939399, 768.3660979691776, 776.6078130544039, 782.2060608482395, 796.0725754495948, 807.2532907061062, 12738.0, 12877.935610321889, 13632.93183534076, 13833.239171845646, 13851.792223116661, 759.4076620236115, 763.171958425115, 763.4350580570338, 766.371575308253, 777.1412589089089, 6023.759049637965, 6149.938500614937, 6186.4741496973265, 6211.937880621226, 6216.502679785606, 155604.22197888937, 156393.0, 158327.0, 159151.0, 160797.0, 112022.87977120125, 124621.0, 142694.0, 143515.2824235893, 143564.0, 119162.0, 122586.38706806408, 123454.0, 126075.3696231513, 127107.36446317709, 13889.374978125807, 14115.364808583434, 14191.64520886986, 14200.715985680023, 14320.06919550226, 58475.4152458487, 58679.41320586739, 58982.70508647429, 60056.0, 60473.0, 75792.24207757851, 77555.0, 77711.74368330202, 78262.0, 78681.60659196667, 19214.654974151676, 19220.71168932439, 19757.604847902672, 19872.205111795945, 20168.49578760543, 19672.606547869247, 19808.801911980696, 20027.45531051322, 20106.899465502578, 20356.389308320773, 20087.0, 20276.290329838386, 20372.69440958357, 20410.489737756674, 20530.589388211854, 19492.902535487232, 19521.316753913547, 19718.40844774659, 19827.603447931248, 19876.00619968967, 19864.404067877986, 19963.301284454974, 20025.49936251547, 20039.899800500905, 20121.094550744958, 15108.54674359771, 15494.612634684223, 15544.844551554339, 15581.610459738144, 15609.921950390175, 15062.189984795146, 15312.464063757716, 15377.154256516, 15478.226088695295, 15643.687126257184], "value": 10408.307257678234, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1372.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 105.0, 105.0, 105.0, 106.0, 110.0, 105.0, 105.0, 105.0, 108.0], "value": 106.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 111.0, 110.0, 116.0, 112.0, 117.0, 110.0, 112.0, 111.0, 141.0], "value": 115.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 163.0, 162.0, 164.0, 161.0, 161.0, 162.0, 164.0, 162.0, 162.0], "value": 162.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 74.0, 74.0, 73.0, 73.0, 73.0, 71.0, 73.0, 74.0], "value": 73.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 78.0, 81.0, 76.0, 77.0, 77.0, 77.0, 79.0, 78.0], "value": 77.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 113.0, 117.0, 116.0, 114.0, 113.0, 113.0, 114.0, 113.0, 116.0], "value": 114.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 150.0, 148.0, 151.0, 150.0, 150.0, 147.0, 148.0, 149.0, 149.0], "value": 149.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 94.0, 95.0, 94.0, 95.0, 94.0, 93.0, 94.0, 94.0, 101.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [47.0, 43.0, 46.0, 43.0, 50.0, 44.0, 48.0, 45.0, 44.0, 44.0], "value": 45.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 39.0, 38.0, 40.0, 39.0, 39.0, 40.0, 40.0, 39.0, 39.0], "value": 39.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 72.0, 73.0, 72.0, 82.0, 75.0, 69.0, 74.0, 71.0, 74.0], "value": 73.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 102.0, 105.0, 105.0, 105.0, 103.0, 105.0, 109.0, 102.0, 109.0], "value": 105.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 152.0, 153.0, 156.0, 154.0, 157.0, 157.0, 154.0, 157.0, 159.0], "value": 155.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 60.0, 60.0, 59.0, 61.0, 62.0, 59.0, 59.0, 59.0, 58.0], "value": 60.1, "unit": "score"}]}]} 08:24:00 INFO - Return code: 0 08:24:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:24:00 INFO - # TBPL SUCCESS # 08:24:00 INFO - Running post-action listener: _package_coverage_data 08:24:00 INFO - Running post-action listener: _resource_record_post_action 08:24:00 INFO - [mozharness: 2017-09-25 15:24:00.592441Z] Finished run-tests step (success) 08:24:00 INFO - Running post-run listener: _resource_record_post_run 08:24:00 INFO - Total resource usage - Wall time: 1182s; CPU: 13.0%; Read bytes: 4096; Write bytes: 285798400; Read time: 16; Write time: 169956 08:24:00 INFO - TinderboxPrint: CPU usage
13.0% 08:24:00 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 08:24:00 INFO - TinderboxPrint: I/O write bytes / time
285,798,400 / 169,956 08:24:00 INFO - TinderboxPrint: CPU idle
8,194.1 (86.9%) 08:24:00 INFO - TinderboxPrint: CPU user
1,179.3 (12.5%) 08:24:00 INFO - TinderboxPrint: Swap in / out
0 / 0 08:24:00 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 81920; Read time: 0; Write time: 20 08:24:00 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 08:24:00 INFO - run-tests - Wall time: 1168s; CPU: 13.0%; Read bytes: 4096; Write bytes: 277164032; Read time: 16; Write time: 169232 08:24:01 INFO - Running post-run listener: _upload_blobber_files 08:24:01 INFO - Blob upload gear active. 08:24:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:24:01 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 08:24:01 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'] 08:24:01 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 08:24:01 INFO - (blobuploader) - INFO - Open directory for files ... 08:24:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:24:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:24:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:24:02 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:24:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:24:02 INFO - (blobuploader) - INFO - Done attempting. 08:24:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:24:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:24:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:24:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:24:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:24:03 INFO - (blobuploader) - INFO - Done attempting. 08:24:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:24:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:24:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:24:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:24:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:24:07 INFO - (blobuploader) - INFO - Done attempting. 08:24:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:24:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:24:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:24:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:24:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:24:08 INFO - (blobuploader) - INFO - Done attempting. 08:24:08 INFO - (blobuploader) - INFO - Iteration through files over. 08:24:08 INFO - Return code: 0 08:24:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:24:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:24:08 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/baaaad0eff14bbfb6957e248e678cf1268255d110b431c86f79a721cf369e2c0ed0501f55bc4bcb119d2e5f1474c9f4725a60290a98b87fec9662c539c3834eb", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/69069f89718d2e122d591540418d8e31399c1f57eb7985fecb76b83126108c05f42504545f9e3fc7b5270a36d59be149d71c7bba8cc12a4a6798cdccd74b37eb", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/d1860bfab307b2b3ea747fec7d915abdfa436535d62c313e996141079da952ea730fab9b55f093c51514be1edc1f595daae76d9ecfcb9757b05b06e19a14900f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/cf685994f95ddee7334406882e9420df9b230cf8c209d0efea44c3611497ee704486a0f3a3d4d7b2a02a7678a83fec14a6b6edc32ab8423141c64895e2a98769"} 08:24:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:24:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:24:08 INFO - Contents: 08:24:08 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/baaaad0eff14bbfb6957e248e678cf1268255d110b431c86f79a721cf369e2c0ed0501f55bc4bcb119d2e5f1474c9f4725a60290a98b87fec9662c539c3834eb", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/69069f89718d2e122d591540418d8e31399c1f57eb7985fecb76b83126108c05f42504545f9e3fc7b5270a36d59be149d71c7bba8cc12a4a6798cdccd74b37eb", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/d1860bfab307b2b3ea747fec7d915abdfa436535d62c313e996141079da952ea730fab9b55f093c51514be1edc1f595daae76d9ecfcb9757b05b06e19a14900f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/cf685994f95ddee7334406882e9420df9b230cf8c209d0efea44c3611497ee704486a0f3a3d4d7b2a02a7678a83fec14a6b6edc32ab8423141c64895e2a98769"} 08:24:08 INFO - Running post-run listener: copy_logs_to_upload_dir 08:24:08 INFO - Copying logs to upload dir... 08:24:08 INFO - mkdir: /builds/slave/test/build/upload/logs 08:24:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1227.524114 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2017-09-25 08:24:08.152636) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-25 08:24:08.156463) ========= 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-1506351790.807965-1201926482 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/baaaad0eff14bbfb6957e248e678cf1268255d110b431c86f79a721cf369e2c0ed0501f55bc4bcb119d2e5f1474c9f4725a60290a98b87fec9662c539c3834eb", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/69069f89718d2e122d591540418d8e31399c1f57eb7985fecb76b83126108c05f42504545f9e3fc7b5270a36d59be149d71c7bba8cc12a4a6798cdccd74b37eb", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/d1860bfab307b2b3ea747fec7d915abdfa436535d62c313e996141079da952ea730fab9b55f093c51514be1edc1f595daae76d9ecfcb9757b05b06e19a14900f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/cf685994f95ddee7334406882e9420df9b230cf8c209d0efea44c3611497ee704486a0f3a3d4d7b2a02a7678a83fec14a6b6edc32ab8423141c64895e2a98769"} build_url:https://queue.taskcluster.net/v1/task/XNXT-O_xRDSxhs9chRjF3Q/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011277 build_url: 'https://queue.taskcluster.net/v1/task/XNXT-O_xRDSxhs9chRjF3Q/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/baaaad0eff14bbfb6957e248e678cf1268255d110b431c86f79a721cf369e2c0ed0501f55bc4bcb119d2e5f1474c9f4725a60290a98b87fec9662c539c3834eb", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/69069f89718d2e122d591540418d8e31399c1f57eb7985fecb76b83126108c05f42504545f9e3fc7b5270a36d59be149d71c7bba8cc12a4a6798cdccd74b37eb", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/d1860bfab307b2b3ea747fec7d915abdfa436535d62c313e996141079da952ea730fab9b55f093c51514be1edc1f595daae76d9ecfcb9757b05b06e19a14900f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/cf685994f95ddee7334406882e9420df9b230cf8c209d0efea44c3611497ee704486a0f3a3d4d7b2a02a7678a83fec14a6b6edc32ab8423141c64895e2a98769"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-25 08:24:08.185703) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 08:24:08.186072) ========= 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-1506351790.807965-1201926482 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004508 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 08:24:08.271145) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-25 08:24:08.271463) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-25 08:24:08.271799) ========= ========= Total master_lag: 0.61 =========