builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-027 starttime: 1508357864.82 results: success (0) revision: d4e212a2b1e1180c245dd528c39500991de311ad ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-10-18 13:17:44.817943) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-10-18 13:17:44.818341) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-18 13:17:44.818608) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-18 13:17:44.831566) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-18 13:17:44.831855) ========= 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=1f5564757af27664ca02d71f000001b0-1508357863.551163-558148248 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-10-18 13:17:44-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 33.5M=0s 2017-10-18 13:17:44 (33.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.145263 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-18 13:17:44.993986) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-18 13:17:44.994304) ========= 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=1f5564757af27664ca02d71f000001b0-1508357863.551163-558148248 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016673 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-18 13:17:45.043576) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-10-18 13:17:45.046931) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev d4e212a2b1e1180c245dd528c39500991de311ad --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 d4e212a2b1e1180c245dd528c39500991de311ad --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=1f5564757af27664ca02d71f000001b0-1508357863.551163-558148248 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-10-18 13:17:45,065 truncating revision to first 12 chars 2017-10-18 13:17:45,065 Setting DEBUG logging. 2017-10-18 13:17:45,066 attempt 1/10 2017-10-18 13:17:45,066 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/d4e212a2b1e1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-10-18 13:17:46,242 unpacking tar archive at: mozilla-beta-d4e212a2b1e1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.474476 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-10-18 13:17:46.544259) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-18 13:17:46.544836) ========= script_repo_revision: d4e212a2b1e1180c245dd528c39500991de311ad ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-18 13:17:46.545442) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-18 13:17:46.548926) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-18 13:17:46.566525) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2017-10-18 13:17:46.566833) ========= /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=1f5564757af27664ca02d71f000001b0-1508357863.551163-558148248 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:17:46 INFO - MultiFileLogger online at 20171018 13:17:46 in /builds/slave/test 13:17:46 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 13:17:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:17:46 INFO - {'append_to_log': False, 13:17:46 INFO - 'base_work_dir': '/builds/slave/test', 13:17:46 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 13:17:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:17:46 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 13:17:46 INFO - 'buildbot_json_path': 'buildprops.json', 13:17:46 INFO - 'code_coverage': False, 13:17:46 INFO - 'config_files': ('talos/linux_config.py',), 13:17:46 INFO - 'default_actions': ('clobber', 13:17:46 INFO - 'read-buildbot-config', 13:17:46 INFO - 'download-and-extract', 13:17:46 INFO - 'populate-webroot', 13:17:46 INFO - 'create-virtualenv', 13:17:46 INFO - 'install', 13:17:46 INFO - 'setup-mitmproxy', 13:17:46 INFO - 'run-tests'), 13:17:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:17:46 INFO - 'disable_ccov_upload': False, 13:17:46 INFO - 'disable_stylo': False, 13:17:46 INFO - 'download_minidump_stackwalk': True, 13:17:46 INFO - 'download_symbols': 'ondemand', 13:17:46 INFO - 'enable_stylo': False, 13:17:46 INFO - 'enable_webrender': False, 13:17:46 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 13:17:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:17:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:17:46 INFO - 'gecko_profile': False, 13:17:46 INFO - 'gecko_profile_interval': 0, 13:17:46 INFO - 'installer_path': 'installer.exe', 13:17:46 INFO - 'log_level': 'info', 13:17:46 INFO - 'log_name': 'talos', 13:17:46 INFO - 'log_to_console': True, 13:17:46 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:17:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:17:46 INFO - 'opt_config_files': (), 13:17:46 INFO - 'pip_index': False, 13:17:46 INFO - 'suite': 'dromaeojs-e10s', 13:17:46 INFO - 'system_bits': '32', 13:17:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:17:46 INFO - 'title': 'talos-linux64-ix-027', 13:17:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:17:46 INFO - 'use_talos_json': True, 13:17:46 INFO - 'verify': 'False', 13:17:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:17:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:17:46 INFO - 'work_dir': 'build'} 13:17:46 INFO - [mozharness: 2017-10-18 20:17:46.730493Z] Running clobber step. 13:17:46 INFO - Running pre-action listener: _resource_record_pre_action 13:17:46 INFO - Running main action method: clobber 13:17:46 INFO - rmtree: /builds/slave/test/build 13:17:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:17:48 INFO - Running post-action listener: _resource_record_post_action 13:17:48 INFO - [mozharness: 2017-10-18 20:17:48.445880Z] Finished clobber step (success) 13:17:48 INFO - [mozharness: 2017-10-18 20:17:48.445977Z] Running read-buildbot-config step. 13:17:48 INFO - Running pre-action listener: _resource_record_pre_action 13:17:48 INFO - Running main action method: read_buildbot_config 13:17:48 INFO - Using buildbot properties: 13:17:48 INFO - { 13:17:48 INFO - "project": "", 13:17:48 INFO - "product": "firefox", 13:17:48 INFO - "who": "ryanvm@gmail.com", 13:17:48 INFO - "installer_path": "public/build/target.tar.bz2", 13:17:48 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 13:17:48 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 13:17:48 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs-e10s", 13:17:48 INFO - "stage_platform": "linux64", 13:17:48 INFO - "basedir": "/builds/slave/test", 13:17:48 INFO - "buildnumber": 168, 13:17:48 INFO - "platform": "ubuntu64_hw", 13:17:48 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:17:48 INFO - "slavebuilddir": "test", 13:17:48 INFO - "taskId": "cVpPmxEQRJK7AHlqflHJuA", 13:17:48 INFO - "branch": "mozilla-beta", 13:17:48 INFO - "script_repo_revision": "production", 13:17:48 INFO - "revision": "d4e212a2b1e1180c245dd528c39500991de311ad", 13:17:48 INFO - "slavename": "talos-linux64-ix-027", 13:17:48 INFO - "repo_path": "releases/mozilla-beta" 13:17:48 INFO - } 13:17:48 INFO - Finding installer, test and symbols from parent task. 13:17:48 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cVpPmxEQRJK7AHlqflHJuA'}, attempt #1 13:17:48 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cVpPmxEQRJK7AHlqflHJuA'}, attempt #1 13:17:49 INFO - Task dependencies: DxSyuDGrTnqOFaD84cZ-Pg 13:17:49 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DxSyuDGrTnqOFaD84cZ-Pg'}, attempt #1 13:17:49 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/DxSyuDGrTnqOFaD84cZ-Pg/artifacts/public/build/target.tar.bz2 13:17:49 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/DxSyuDGrTnqOFaD84cZ-Pg/artifacts/public/build/target.test_packages.json 13:17:49 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/DxSyuDGrTnqOFaD84cZ-Pg/artifacts/public/build/target.crashreporter-symbols.zip 13:17:49 INFO - Running post-action listener: _resource_record_post_action 13:17:49 INFO - [mozharness: 2017-10-18 20:17:49.898350Z] Finished read-buildbot-config step (success) 13:17:49 INFO - [mozharness: 2017-10-18 20:17:49.898564Z] Running download-and-extract step. 13:17:49 INFO - Running pre-action listener: _resource_record_pre_action 13:17:49 INFO - Running main action method: download_and_extract 13:17:49 INFO - mkdir: /builds/slave/test/build/tests 13:17:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:17:49 INFO - trying https://queue.taskcluster.net/v1/task/DxSyuDGrTnqOFaD84cZ-Pg/artifacts/public/build/target.test_packages.json 13:17:49 INFO - Downloading https://queue.taskcluster.net/v1/task/DxSyuDGrTnqOFaD84cZ-Pg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 13:17:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DxSyuDGrTnqOFaD84cZ-Pg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 13:17:50 INFO - Downloaded 989 bytes. 13:17:50 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 13:17:50 INFO - Using the following test package requirements: 13:17:50 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 13:17:50 INFO - u'common': [u'target.common.tests.zip'], 13:17:50 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 13:17:50 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 13:17:50 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 13:17:50 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 13:17:50 INFO - u'mozbase': [u'target.common.tests.zip'], 13:17:50 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 13:17:50 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 13:17:50 INFO - u'web-platform': [u'target.common.tests.zip', 13:17:50 INFO - u'target.web-platform.tests.tar.gz'], 13:17:50 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 13:17:50 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 13:17:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DxSyuDGrTnqOFaD84cZ-Pg/artifacts/public/build/target.common.tests.zip 13:17:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DxSyuDGrTnqOFaD84cZ-Pg/artifacts/public/build/target.common.tests.zip'}, attempt #1 13:17:50 INFO - Fetch https://queue.taskcluster.net/v1/task/DxSyuDGrTnqOFaD84cZ-Pg/artifacts/public/build/target.common.tests.zip into memory 13:17:52 INFO - Content-Length response header: 55173000 13:17:52 INFO - Bytes received: 55173000 13:18:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DxSyuDGrTnqOFaD84cZ-Pg/artifacts/public/build/target.talos.tests.zip 13:18:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DxSyuDGrTnqOFaD84cZ-Pg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 13:18:03 INFO - Fetch https://queue.taskcluster.net/v1/task/DxSyuDGrTnqOFaD84cZ-Pg/artifacts/public/build/target.talos.tests.zip into memory 13:18:04 INFO - Content-Length response header: 14509251 13:18:04 INFO - Bytes received: 14509251 13:18:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:18:04 INFO - trying https://queue.taskcluster.net/v1/task/DxSyuDGrTnqOFaD84cZ-Pg/artifacts/public/build/target.tar.bz2 13:18:04 INFO - Downloading https://queue.taskcluster.net/v1/task/DxSyuDGrTnqOFaD84cZ-Pg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 13:18:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DxSyuDGrTnqOFaD84cZ-Pg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 13:18:06 INFO - Downloaded 53713337 bytes. 13:18:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DxSyuDGrTnqOFaD84cZ-Pg/artifacts/public/build/target.tar.bz2 13:18:06 INFO - mkdir: /builds/slave/test/properties 13:18:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:18:06 INFO - Writing to file /builds/slave/test/properties/build_url 13:18:06 INFO - Contents: 13:18:06 INFO - build_url:https://queue.taskcluster.net/v1/task/DxSyuDGrTnqOFaD84cZ-Pg/artifacts/public/build/target.tar.bz2 13:18:06 INFO - Running post-action listener: _resource_record_post_action 13:18:06 INFO - Running post-action listener: find_tests_for_verification 13:18:06 INFO - Running post-action listener: set_extra_try_arguments 13:18:06 INFO - [mozharness: 2017-10-18 20:18:06.106899Z] Finished download-and-extract step (success) 13:18:06 INFO - [mozharness: 2017-10-18 20:18:06.107127Z] Running populate-webroot step. 13:18:06 INFO - Running pre-action listener: _resource_record_pre_action 13:18:06 INFO - Running main action method: populate_webroot 13:18:06 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:18:06 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:18:06 INFO - 'tests': ['tresize', 13:18:06 INFO - 'tcanvasmark']}, 13:18:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:18:06 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:18:06 INFO - 'tests': ['dromaeo_css', 13:18:06 INFO - 'kraken']}, 13:18:06 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 13:18:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:18:06 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 13:18:06 INFO - 'talos_options': ['--disable-stylo'], 13:18:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:18:06 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 13:18:06 INFO - 'tests': ['damp', 'tps']}, 13:18:06 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 13:18:06 INFO - 'talos_options': ['--disable-stylo'], 13:18:06 INFO - 'tests': ['damp', 'tps']}, 13:18:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:18:06 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:18:06 INFO - 'tests': ['dromaeo_dom']}, 13:18:06 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 13:18:06 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:18:06 INFO - 'tests': ['basic_compositor_video', 13:18:06 INFO - 'glvideo']}, 13:18:06 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 13:18:06 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 13:18:06 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 13:18:06 INFO - 'talos_options': ['--disable-stylo'], 13:18:06 INFO - 'tests': ['ts_paint_webext', 13:18:06 INFO - 'tp5o_webext']}, 13:18:06 INFO - 'other-e10s': {'tests': ['a11yr', 13:18:06 INFO - 'ts_paint', 13:18:06 INFO - 'tpaint', 13:18:06 INFO - 'sessionrestore', 13:18:06 INFO - 'sessionrestore_many_windows', 13:18:06 INFO - 'sessionrestore_no_auto_restore', 13:18:06 INFO - 'tabpaint']}, 13:18:06 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:18:06 INFO - 'tests': ['a11yr', 13:18:06 INFO - 'ts_paint', 13:18:06 INFO - 'tpaint', 13:18:06 INFO - 'sessionrestore', 13:18:06 INFO - 'sessionrestore_many_windows', 13:18:06 INFO - 'sessionrestore_no_auto_restore', 13:18:06 INFO - 'tabpaint']}, 13:18:06 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 13:18:06 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 13:18:06 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:18:06 INFO - 'tests': ['perf_reftest_singletons']}, 13:18:06 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:18:06 INFO - 'tests': ['bloom_basic']}, 13:18:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:18:06 INFO - 'tsvgr_opacity', 13:18:06 INFO - 'tart', 13:18:06 INFO - 'tscrollx', 13:18:06 INFO - 'tsvg_static']}, 13:18:06 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:18:06 INFO - 'tests': ['tsvgx', 13:18:06 INFO - 'tsvgr_opacity', 13:18:06 INFO - 'tart', 13:18:06 INFO - 'tscrollx', 13:18:06 INFO - 'tsvg_static']}, 13:18:06 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 13:18:06 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 13:18:06 INFO - 'talos_options': ['--disable-stylo'], 13:18:06 INFO - 'tests': ['tp5o']}, 13:18:06 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 13:18:06 INFO - 'talos_options': ['--mitmproxy', 13:18:06 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 13:18:06 INFO - '--firstNonBlankPaint'], 13:18:06 INFO - 'tests': ['tp6_google', 13:18:06 INFO - 'tp6_youtube', 13:18:06 INFO - 'tp6_amazon', 13:18:06 INFO - 'tp6_facebook']}, 13:18:06 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 13:18:06 INFO - 'talos_options': ['--disable-stylo', 13:18:06 INFO - '--mitmproxy', 13:18:06 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 13:18:06 INFO - '--firstNonBlankPaint'], 13:18:06 INFO - 'tests': ['tp6_google', 13:18:06 INFO - 'tp6_youtube', 13:18:06 INFO - 'tp6_amazon', 13:18:06 INFO - 'tp6_facebook']}, 13:18:06 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 13:18:06 INFO - 'talos_options': ['--stylo-threads=1', 13:18:06 INFO - '--mitmproxy', 13:18:06 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 13:18:06 INFO - '--firstNonBlankPaint'], 13:18:06 INFO - 'tests': ['tp6_google', 13:18:06 INFO - 'tp6_youtube', 13:18:06 INFO - 'tp6_amazon', 13:18:06 INFO - 'tp6_facebook']}, 13:18:06 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 13:18:06 INFO - 'talos_options': ['--xperf_path', 13:18:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:18:06 INFO - 'tests': ['tp5n']}, 13:18:06 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 13:18:06 INFO - 'talos_options': ['--disable-stylo', 13:18:06 INFO - '--xperf_path', 13:18:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:18:06 INFO - 'tests': ['tp5n']}}} 13:18:06 INFO - Running post-action listener: _resource_record_post_action 13:18:06 INFO - [mozharness: 2017-10-18 20:18:06.127114Z] Finished populate-webroot step (success) 13:18:06 INFO - [mozharness: 2017-10-18 20:18:06.127203Z] Running create-virtualenv step. 13:18:06 INFO - Running pre-action listener: _resource_record_pre_action 13:18:06 INFO - Running main action method: create_virtualenv 13:18:06 INFO - Creating virtualenv /builds/slave/test/build/venv 13:18:06 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 13:18:06 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 13:18:06 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 13:18:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:18:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:18:07 INFO - Installing distribute.............................................................................................................................................................................................done. 13:18:07 INFO - Installing pip...............done. 13:18:07 INFO - Return code: 0 13:18:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:18:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:18:07 INFO - Reading from file tmpfile_stdout 13:18:07 INFO - Output received: 13:18:07 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 13:18:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:18:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:18:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:18:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:18:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:18:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x255ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2560090>, '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 0x2560d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255af90>, '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': '1f5564757af27664ca02d71f000001b0-1508357863.551163-558148248', '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 13:18:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:18:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:18:07 INFO - Using env: {'DISPLAY': ':0', 13:18:07 INFO - 'HOME': '/home/cltbld', 13:18:07 INFO - 'LANG': 'en_US.UTF-8', 13:18:07 INFO - 'LANGUAGE': 'en_US:en', 13:18:07 INFO - 'LOGNAME': 'cltbld', 13:18:07 INFO - 'MAIL': '/var/mail/cltbld', 13:18:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:18:07 INFO - 'MOZ_NO_REMOTE': '1', 13:18:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:18:07 INFO - 'NO_EM_RESTART': '1', 13:18:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:18:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:18:07 INFO - 'PWD': '/builds/slave/test', 13:18:07 INFO - 'SHELL': '/bin/bash', 13:18:07 INFO - 'SHLVL': '1', 13:18:07 INFO - 'TERM': 'linux', 13:18:07 INFO - 'TMOUT': '86400', 13:18:07 INFO - 'USER': 'cltbld', 13:18:07 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1508357863.551163-558148248', 13:18:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:18:07 INFO - '_': '/tools/buildbot/bin/python'} 13:18:08 INFO - Ignoring indexes: http://pypi.python.org/simple/ 13:18:08 INFO - Downloading/unpacking pip>=1.5 13:18:08 INFO - Running setup.py egg_info for package pip 13:18:08 INFO - warning: no files found matching 'pip/cacert.pem' 13:18:08 INFO - warning: no files found matching '*.html' under directory 'docs' 13:18:08 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 13:18:08 INFO - no previously-included directories found matching 'docs/_build/_sources' 13:18:08 INFO - Installing collected packages: pip 13:18:08 INFO - Found existing installation: pip 1.1 13:18:08 INFO - Uninstalling pip: 13:18:08 INFO - Successfully uninstalled pip 13:18:08 INFO - Running setup.py install for pip 13:18:08 INFO - warning: no files found matching 'pip/cacert.pem' 13:18:08 INFO - warning: no files found matching '*.html' under directory 'docs' 13:18:08 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 13:18:08 INFO - no previously-included directories found matching 'docs/_build/_sources' 13:18:08 INFO - Installing pip script to /builds/slave/test/build/venv/bin 13:18:08 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 13:18:08 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 13:18:08 INFO - Successfully installed pip 13:18:08 INFO - Cleaning up... 13:18:08 INFO - Return code: 0 13:18:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:18:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:18:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:18:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:18:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:18:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x21f11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x255ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2560090>, '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 0x2560d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255af90>, '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': '1f5564757af27664ca02d71f000001b0-1508357863.551163-558148248', '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 13:18:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:18:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:18:08 INFO - Using env: {'DISPLAY': ':0', 13:18:08 INFO - 'HOME': '/home/cltbld', 13:18:08 INFO - 'LANG': 'en_US.UTF-8', 13:18:08 INFO - 'LANGUAGE': 'en_US:en', 13:18:08 INFO - 'LOGNAME': 'cltbld', 13:18:08 INFO - 'MAIL': '/var/mail/cltbld', 13:18:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:18:08 INFO - 'MOZ_NO_REMOTE': '1', 13:18:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:18:08 INFO - 'NO_EM_RESTART': '1', 13:18:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:18:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:18:08 INFO - 'PWD': '/builds/slave/test', 13:18:08 INFO - 'SHELL': '/bin/bash', 13:18:08 INFO - 'SHLVL': '1', 13:18:08 INFO - 'TERM': 'linux', 13:18:08 INFO - 'TMOUT': '86400', 13:18:08 INFO - 'USER': 'cltbld', 13:18:08 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1508357863.551163-558148248', 13:18:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:18:08 INFO - '_': '/tools/buildbot/bin/python'} 13:18:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:18:09 INFO - Downloading/unpacking psutil>=3.1.1 13:18:09 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 13:18:09 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 13:18:09 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 13:18:09 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 13:18:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:18:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:18:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:18:10 INFO - Installing collected packages: psutil 13:18:10 INFO - Running setup.py install for psutil 13:18:10 INFO - building 'psutil._psutil_linux' extension 13:18:10 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 13:18:11 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 13:18:11 INFO - building 'psutil._psutil_posix' extension 13:18:11 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 13:18:11 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 13:18:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:18:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:18:11 INFO - Successfully installed psutil 13:18:11 INFO - Cleaning up... 13:18:11 INFO - Return code: 0 13:18:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:18:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:18:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:18:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:18:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:18:11 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 0x21f11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x255ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2560090>, '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 0x2560d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255af90>, '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': '1f5564757af27664ca02d71f000001b0-1508357863.551163-558148248', '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 13:18:11 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 13:18:11 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 13:18:11 INFO - Using env: {'DISPLAY': ':0', 13:18:11 INFO - 'HOME': '/home/cltbld', 13:18:11 INFO - 'LANG': 'en_US.UTF-8', 13:18:11 INFO - 'LANGUAGE': 'en_US:en', 13:18:11 INFO - 'LOGNAME': 'cltbld', 13:18:11 INFO - 'MAIL': '/var/mail/cltbld', 13:18:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:18:11 INFO - 'MOZ_NO_REMOTE': '1', 13:18:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:18:11 INFO - 'NO_EM_RESTART': '1', 13:18:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:18:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:18:11 INFO - 'PWD': '/builds/slave/test', 13:18:11 INFO - 'SHELL': '/bin/bash', 13:18:11 INFO - 'SHLVL': '1', 13:18:11 INFO - 'TERM': 'linux', 13:18:11 INFO - 'TMOUT': '86400', 13:18:11 INFO - 'USER': 'cltbld', 13:18:11 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1508357863.551163-558148248', 13:18:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:18:11 INFO - '_': '/tools/buildbot/bin/python'} 13:18:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:18:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:18:11 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 13:18:11 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 13:18:11 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 13:18:11 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 13:18:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:18:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:18:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:18:13 INFO - Installing collected packages: mozsystemmonitor 13:18:13 INFO - Running setup.py install for mozsystemmonitor 13:18:14 INFO - Successfully installed mozsystemmonitor 13:18:14 INFO - Cleaning up... 13:18:14 INFO - Return code: 0 13:18:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:18:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:18:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:18:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:18:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:18:14 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 0x21f11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x255ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2560090>, '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 0x2560d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255af90>, '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': '1f5564757af27664ca02d71f000001b0-1508357863.551163-558148248', '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 13:18:14 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 13:18:14 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 13:18:14 INFO - Using env: {'DISPLAY': ':0', 13:18:14 INFO - 'HOME': '/home/cltbld', 13:18:14 INFO - 'LANG': 'en_US.UTF-8', 13:18:14 INFO - 'LANGUAGE': 'en_US:en', 13:18:14 INFO - 'LOGNAME': 'cltbld', 13:18:14 INFO - 'MAIL': '/var/mail/cltbld', 13:18:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:18:14 INFO - 'MOZ_NO_REMOTE': '1', 13:18:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:18:14 INFO - 'NO_EM_RESTART': '1', 13:18:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:18:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:18:14 INFO - 'PWD': '/builds/slave/test', 13:18:14 INFO - 'SHELL': '/bin/bash', 13:18:14 INFO - 'SHLVL': '1', 13:18:14 INFO - 'TERM': 'linux', 13:18:14 INFO - 'TMOUT': '86400', 13:18:14 INFO - 'USER': 'cltbld', 13:18:14 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1508357863.551163-558148248', 13:18:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:18:14 INFO - '_': '/tools/buildbot/bin/python'} 13:18:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:18:14 INFO - Downloading/unpacking jsonschema==2.5.1 13:18:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:18:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:18:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:18:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:18:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:18:16 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:18:16 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 13:18:16 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 13:18:16 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 13:18:16 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 13:18:16 INFO - Downloading functools32-3.2.3-2.tar.gz 13:18:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:18:16 INFO - warning: no files found matching '*.txt' 13:18:16 INFO - no previously-included directories found matching 'build' 13:18:16 INFO - no previously-included directories found matching 'dist' 13:18:16 INFO - no previously-included directories found matching '.git*' 13:18:16 INFO - Installing collected packages: jsonschema, functools32 13:18:16 INFO - Running setup.py install for functools32 13:18:16 INFO - warning: no files found matching '*.txt' 13:18:16 INFO - no previously-included directories found matching 'build' 13:18:16 INFO - no previously-included directories found matching 'dist' 13:18:16 INFO - no previously-included directories found matching '.git*' 13:18:16 INFO - Successfully installed jsonschema functools32 13:18:16 INFO - Cleaning up... 13:18:16 INFO - Return code: 0 13:18:16 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:18:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:18:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:18:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:18:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:18:16 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 0x21f11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x255ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2560090>, '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 0x2560d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255af90>, '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': '1f5564757af27664ca02d71f000001b0-1508357863.551163-558148248', '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 13:18:16 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 13:18:16 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 13:18:16 INFO - Using env: {'DISPLAY': ':0', 13:18:16 INFO - 'HOME': '/home/cltbld', 13:18:16 INFO - 'LANG': 'en_US.UTF-8', 13:18:16 INFO - 'LANGUAGE': 'en_US:en', 13:18:16 INFO - 'LOGNAME': 'cltbld', 13:18:16 INFO - 'MAIL': '/var/mail/cltbld', 13:18:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:18:16 INFO - 'MOZ_NO_REMOTE': '1', 13:18:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:18:16 INFO - 'NO_EM_RESTART': '1', 13:18:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:18:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:18:16 INFO - 'PWD': '/builds/slave/test', 13:18:16 INFO - 'SHELL': '/bin/bash', 13:18:16 INFO - 'SHLVL': '1', 13:18:16 INFO - 'TERM': 'linux', 13:18:16 INFO - 'TMOUT': '86400', 13:18:16 INFO - 'USER': 'cltbld', 13:18:16 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1508357863.551163-558148248', 13:18:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:18:16 INFO - '_': '/tools/buildbot/bin/python'} 13:18:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:18:16 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:18:16 INFO - Cleaning up... 13:18:16 INFO - Return code: 0 13:18:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:18:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:18:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:18:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:18:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:18:16 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 0x21f11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x255ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2560090>, '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 0x2560d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255af90>, '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': '1f5564757af27664ca02d71f000001b0-1508357863.551163-558148248', '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 13:18:16 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 13:18:16 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 13:18:16 INFO - Using env: {'DISPLAY': ':0', 13:18:16 INFO - 'HOME': '/home/cltbld', 13:18:16 INFO - 'LANG': 'en_US.UTF-8', 13:18:16 INFO - 'LANGUAGE': 'en_US:en', 13:18:16 INFO - 'LOGNAME': 'cltbld', 13:18:16 INFO - 'MAIL': '/var/mail/cltbld', 13:18:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:18:16 INFO - 'MOZ_NO_REMOTE': '1', 13:18:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:18:16 INFO - 'NO_EM_RESTART': '1', 13:18:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:18:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:18:16 INFO - 'PWD': '/builds/slave/test', 13:18:16 INFO - 'SHELL': '/bin/bash', 13:18:16 INFO - 'SHLVL': '1', 13:18:16 INFO - 'TERM': 'linux', 13:18:16 INFO - 'TMOUT': '86400', 13:18:16 INFO - 'USER': 'cltbld', 13:18:16 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1508357863.551163-558148248', 13:18:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:18:16 INFO - '_': '/tools/buildbot/bin/python'} 13:18:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:18:16 INFO - Downloading/unpacking blobuploader==1.2.4 13:18:16 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 13:18:16 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 13:18:16 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 13:18:16 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 13:18:17 INFO - Downloading blobuploader-1.2.4.tar.gz 13:18:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:18:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:18:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:18:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:18:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:18:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:18:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:18:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:18:18 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 13:18:18 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 13:18:18 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 13:18:18 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 13:18:18 INFO - Downloading docopt-0.6.1.tar.gz 13:18:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:18:18 INFO - Installing collected packages: blobuploader, requests, docopt 13:18:18 INFO - Running setup.py install for blobuploader 13:18:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:18:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:18:18 INFO - Running setup.py install for requests 13:18:18 INFO - Running setup.py install for docopt 13:18:19 INFO - Successfully installed blobuploader requests docopt 13:18:19 INFO - Cleaning up... 13:18:19 INFO - Return code: 0 13:18:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:18:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:18:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:18:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:18:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:18:19 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 0x21f11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x255ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2560090>, '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 0x2560d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255af90>, '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': '1f5564757af27664ca02d71f000001b0-1508357863.551163-558148248', '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 13:18:19 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 13:18:19 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 13:18:19 INFO - Using env: {'DISPLAY': ':0', 13:18:19 INFO - 'HOME': '/home/cltbld', 13:18:19 INFO - 'LANG': 'en_US.UTF-8', 13:18:19 INFO - 'LANGUAGE': 'en_US:en', 13:18:19 INFO - 'LOGNAME': 'cltbld', 13:18:19 INFO - 'MAIL': '/var/mail/cltbld', 13:18:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:18:19 INFO - 'MOZ_NO_REMOTE': '1', 13:18:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:18:19 INFO - 'NO_EM_RESTART': '1', 13:18:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:18:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:18:19 INFO - 'PWD': '/builds/slave/test', 13:18:19 INFO - 'SHELL': '/bin/bash', 13:18:19 INFO - 'SHLVL': '1', 13:18:19 INFO - 'TERM': 'linux', 13:18:19 INFO - 'TMOUT': '86400', 13:18:19 INFO - 'USER': 'cltbld', 13:18:19 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1508357863.551163-558148248', 13:18:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:18:19 INFO - '_': '/tools/buildbot/bin/python'} 13:18:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:18:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:18:19 INFO - Running setup.py (path:/tmp/pip-xYVkLB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:18:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:18:19 INFO - Running setup.py (path:/tmp/pip-tQZ61a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:18:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:18:19 INFO - Running setup.py (path:/tmp/pip-cCXSs6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:18:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:18:19 INFO - Running setup.py (path:/tmp/pip-5SXjIf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:18:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:18:19 INFO - Running setup.py (path:/tmp/pip-_2ShKJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:18:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:18:19 INFO - Running setup.py (path:/tmp/pip-hhneQ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:18:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:18:19 INFO - Running setup.py (path:/tmp/pip-vZnrKm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:18:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:18:19 INFO - Running setup.py (path:/tmp/pip-jt6eBe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:18:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:18:19 INFO - Running setup.py (path:/tmp/pip-Qym13k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:18:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:18:19 INFO - Running setup.py (path:/tmp/pip-STmjMu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:18:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:18:20 INFO - Running setup.py (path:/tmp/pip-iAT8VM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:18:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:18:20 INFO - Running setup.py (path:/tmp/pip-RyWaMG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:18:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:18:20 INFO - Running setup.py (path:/tmp/pip-tJQEtC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:18:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:18:20 INFO - Running setup.py (path:/tmp/pip-jk9paB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:18:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:18:20 INFO - Running setup.py (path:/tmp/pip-58tOnR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:18:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:18:20 INFO - Running setup.py (path:/tmp/pip-6gkJC9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:18:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:18:20 INFO - Running setup.py (path:/tmp/pip-GeQGP5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:18:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:18:20 INFO - Running setup.py install for manifestparser 13:18:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:18:20 INFO - Running setup.py install for mozcrash 13:18:20 INFO - Running setup.py install for mozdebug 13:18:20 INFO - Running setup.py install for mozdevice 13:18:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:18:20 INFO - Running setup.py install for mozfile 13:18:21 INFO - Running setup.py install for mozhttpd 13:18:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:18:21 INFO - Running setup.py install for mozinfo 13:18:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:18:21 INFO - Running setup.py install for mozInstall 13:18:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:18:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:18:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:18:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:18:21 INFO - Running setup.py install for mozleak 13:18:21 INFO - Running setup.py install for mozlog 13:18:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:18:21 INFO - Running setup.py install for moznetwork 13:18:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:18:21 INFO - Running setup.py install for mozprocess 13:18:21 INFO - Running setup.py install for mozprofile 13:18:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:18:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:18:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:18:21 INFO - Running setup.py install for mozrunner 13:18:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:18:21 INFO - Running setup.py install for mozscreenshot 13:18:22 INFO - Running setup.py install for moztest 13:18:22 INFO - Running setup.py install for mozversion 13:18:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:18:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:18:22 INFO - Cleaning up... 13:18:22 INFO - Return code: 0 13:18:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:18:22 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')]} 13:18:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:18:22 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')]} 13:18:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:18:22 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 0x21f11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x255ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2560090>, '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 0x2560d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255af90>, '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': '1f5564757af27664ca02d71f000001b0-1508357863.551163-558148248', '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 13:18:22 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 13:18:22 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 13:18:22 INFO - Using env: {'DISPLAY': ':0', 13:18:22 INFO - 'HOME': '/home/cltbld', 13:18:22 INFO - 'LANG': 'en_US.UTF-8', 13:18:22 INFO - 'LANGUAGE': 'en_US:en', 13:18:22 INFO - 'LOGNAME': 'cltbld', 13:18:22 INFO - 'MAIL': '/var/mail/cltbld', 13:18:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:18:22 INFO - 'MOZ_NO_REMOTE': '1', 13:18:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:18:22 INFO - 'NO_EM_RESTART': '1', 13:18:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:18:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:18:22 INFO - 'PWD': '/builds/slave/test', 13:18:22 INFO - 'SHELL': '/bin/bash', 13:18:22 INFO - 'SHLVL': '1', 13:18:22 INFO - 'TERM': 'linux', 13:18:22 INFO - 'TMOUT': '86400', 13:18:22 INFO - 'USER': 'cltbld', 13:18:22 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1508357863.551163-558148248', 13:18:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:18:22 INFO - '_': '/tools/buildbot/bin/python'} 13:18:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:18:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:18:22 INFO - Running setup.py (path:/tmp/pip-qnhwB0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:18:22 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)) 13:18:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:18:22 INFO - Running setup.py (path:/tmp/pip-f9vGUI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:18:22 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)) 13:18:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:18:22 INFO - Running setup.py (path:/tmp/pip-CdzGZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:18:22 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)) 13:18:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:18:22 INFO - Running setup.py (path:/tmp/pip-yS1TPC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:18:22 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)) 13:18:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:18:22 INFO - Running setup.py (path:/tmp/pip-sKsLwZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:18:22 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)) 13:18:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:18:22 INFO - Running setup.py (path:/tmp/pip-E6MfHS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:18:22 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)) 13:18:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:18:22 INFO - Running setup.py (path:/tmp/pip-BwcEpS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:18:23 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)) 13:18:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:18:23 INFO - Running setup.py (path:/tmp/pip-I5azrL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:18:23 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)) 13:18:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:18:23 INFO - Running setup.py (path:/tmp/pip-Oslthu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:18:23 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)) 13:18:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:18:23 INFO - Running setup.py (path:/tmp/pip-Q8dM1x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:18:23 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)) 13:18:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:18:23 INFO - Running setup.py (path:/tmp/pip-pG5IsY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:18:23 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)) 13:18:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:18:23 INFO - Running setup.py (path:/tmp/pip-Pp_1ht-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:18:23 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)) 13:18:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:18:23 INFO - Running setup.py (path:/tmp/pip-lV1eIf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:18:23 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)) 13:18:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:18:23 INFO - Running setup.py (path:/tmp/pip-lypcdY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:18:23 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)) 13:18:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:18:23 INFO - Running setup.py (path:/tmp/pip-IjmXfw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:18:23 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)) 13:18:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:18:23 INFO - Running setup.py (path:/tmp/pip-H00c5e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:18:23 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)) 13:18:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:18:23 INFO - Running setup.py (path:/tmp/pip-zOgFYV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:18:23 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)) 13:18:23 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)) 13:18:23 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)) 13:18:23 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)) 13:18:23 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)) 13:18:23 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)) 13:18:23 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)) 13:18:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:18:23 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 13:18:23 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 13:18:23 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 13:18:23 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 13:18:24 INFO - Downloading blessings-1.6.tar.gz 13:18:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:18:24 INFO - Installing collected packages: blessings 13:18:24 INFO - Running setup.py install for blessings 13:18:25 INFO - Successfully installed blessings 13:18:25 INFO - Cleaning up... 13:18:25 INFO - Return code: 0 13:18:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:18:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:18:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:18:25 INFO - Reading from file tmpfile_stdout 13:18:25 INFO - Current package versions: 13:18:25 INFO - argparse == 1.2.1 13:18:25 INFO - blessings == 1.6 13:18:25 INFO - blobuploader == 1.2.4 13:18:25 INFO - docopt == 0.6.1 13:18:25 INFO - functools32 == 3.2.3-2 13:18:25 INFO - jsonschema == 2.5.1 13:18:25 INFO - manifestparser == 1.1 13:18:25 INFO - mozInstall == 1.13 13:18:25 INFO - mozcrash == 1.0 13:18:25 INFO - mozdebug == 0.1 13:18:25 INFO - mozdevice == 0.51 13:18:25 INFO - mozfile == 1.2 13:18:25 INFO - mozhttpd == 0.7 13:18:25 INFO - mozinfo == 0.10 13:18:25 INFO - mozleak == 0.1 13:18:25 INFO - mozlog == 3.5 13:18:25 INFO - moznetwork == 0.27 13:18:25 INFO - mozprocess == 0.25 13:18:25 INFO - mozprofile == 0.28 13:18:25 INFO - mozrunner == 6.13 13:18:25 INFO - mozscreenshot == 0.1 13:18:25 INFO - mozsystemmonitor == 0.3 13:18:25 INFO - moztest == 0.8 13:18:25 INFO - mozversion == 1.4 13:18:25 INFO - psutil == 3.1.1 13:18:25 INFO - requests == 1.2.3 13:18:25 INFO - wsgiref == 0.1.2 13:18:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:18:25 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')]} 13:18:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:18:25 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')]} 13:18:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:18:25 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 0x21f11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x255ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2560090>, '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 0x2560d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255af90>, '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': '1f5564757af27664ca02d71f000001b0-1508357863.551163-558148248', '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 13:18:25 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 13:18:25 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 13:18:25 INFO - Using env: {'DISPLAY': ':0', 13:18:25 INFO - 'HOME': '/home/cltbld', 13:18:25 INFO - 'LANG': 'en_US.UTF-8', 13:18:25 INFO - 'LANGUAGE': 'en_US:en', 13:18:25 INFO - 'LOGNAME': 'cltbld', 13:18:25 INFO - 'MAIL': '/var/mail/cltbld', 13:18:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:18:25 INFO - 'MOZ_NO_REMOTE': '1', 13:18:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:18:25 INFO - 'NO_EM_RESTART': '1', 13:18:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:18:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:18:25 INFO - 'PWD': '/builds/slave/test', 13:18:25 INFO - 'SHELL': '/bin/bash', 13:18:25 INFO - 'SHLVL': '1', 13:18:25 INFO - 'TERM': 'linux', 13:18:25 INFO - 'TMOUT': '86400', 13:18:25 INFO - 'USER': 'cltbld', 13:18:25 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1508357863.551163-558148248', 13:18:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:18:25 INFO - '_': '/tools/buildbot/bin/python'} 13:18:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:18:25 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)) 13:18:25 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)) 13:18:25 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)) 13:18:25 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)) 13:18:25 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)) 13:18:25 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)) 13:18:25 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)) 13:18:25 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)) 13:18:25 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)) 13:18:25 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 13:18:25 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 13:18:25 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 13:18:25 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 13:18:25 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 13:18:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 13:18:26 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)) 13:18:26 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)) 13:18:26 INFO - Installing collected packages: simplejson 13:18:26 INFO - Running setup.py install for simplejson 13:18:26 INFO - building 'simplejson._speedups' extension 13:18:26 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 13:18:27 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 13:18:27 INFO - Successfully installed simplejson 13:18:27 INFO - Cleaning up... 13:18:27 INFO - Return code: 0 13:18:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:18:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:18:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:18:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:18:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:18:27 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 0x21f11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x255ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2560090>, '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 0x2560d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255af90>, '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': '1f5564757af27664ca02d71f000001b0-1508357863.551163-558148248', '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 13:18:27 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 13:18:27 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 13:18:27 INFO - Using env: {'DISPLAY': ':0', 13:18:27 INFO - 'HOME': '/home/cltbld', 13:18:27 INFO - 'LANG': 'en_US.UTF-8', 13:18:27 INFO - 'LANGUAGE': 'en_US:en', 13:18:27 INFO - 'LOGNAME': 'cltbld', 13:18:27 INFO - 'MAIL': '/var/mail/cltbld', 13:18:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:18:27 INFO - 'MOZ_NO_REMOTE': '1', 13:18:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:18:27 INFO - 'NO_EM_RESTART': '1', 13:18:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:18:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:18:27 INFO - 'PWD': '/builds/slave/test', 13:18:27 INFO - 'SHELL': '/bin/bash', 13:18:27 INFO - 'SHLVL': '1', 13:18:27 INFO - 'TERM': 'linux', 13:18:27 INFO - 'TMOUT': '86400', 13:18:27 INFO - 'USER': 'cltbld', 13:18:27 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1508357863.551163-558148248', 13:18:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:18:27 INFO - '_': '/tools/buildbot/bin/python'} 13:18:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:18:27 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:18:27 INFO - Cleaning up... 13:18:27 INFO - Return code: 0 13:18:27 INFO - Running post-action listener: _resource_record_post_action 13:18:27 INFO - Running post-action listener: _start_resource_monitoring 13:18:28 INFO - Starting resource monitoring. 13:18:28 INFO - [mozharness: 2017-10-18 20:18:28.019946Z] Finished create-virtualenv step (success) 13:18:28 INFO - [mozharness: 2017-10-18 20:18:28.020408Z] Running install step. 13:18:28 INFO - Running pre-action listener: _resource_record_pre_action 13:18:28 INFO - Running main action method: install 13:18:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:18:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:18:28 INFO - Reading from file tmpfile_stdout 13:18:28 INFO - Detecting whether we're running mozinstall >=1.0... 13:18:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:18:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:18:28 INFO - Reading from file tmpfile_stdout 13:18:28 INFO - Output received: 13:18:28 INFO - Usage: mozinstall [options] installer 13:18:28 INFO - Options: 13:18:28 INFO - -h, --help show this help message and exit 13:18:28 INFO - -d DEST, --destination=DEST 13:18:28 INFO - Directory to install application into. [default: 13:18:28 INFO - "/builds/slave/test"] 13:18:28 INFO - --app=APP Application being installed. [default: firefox] 13:18:28 INFO - mkdir: /builds/slave/test/build/application 13:18:28 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'] 13:18:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 13:18:43 INFO - Reading from file tmpfile_stdout 13:18:43 INFO - Output received: 13:18:43 INFO - /builds/slave/test/build/application/firefox/firefox 13:18:43 INFO - Running post-action listener: _resource_record_post_action 13:18:43 INFO - [mozharness: 2017-10-18 20:18:43.002885Z] Finished install step (success) 13:18:43 INFO - [mozharness: 2017-10-18 20:18:43.003032Z] Running setup-mitmproxy step. 13:18:43 INFO - Running pre-action listener: _resource_record_pre_action 13:18:43 INFO - Running main action method: setup_mitmproxy 13:18:43 INFO - Skipping: mitmproxy is not required 13:18:43 INFO - Running post-action listener: _resource_record_post_action 13:18:43 INFO - [mozharness: 2017-10-18 20:18:43.003963Z] Finished setup-mitmproxy step (success) 13:18:43 INFO - [mozharness: 2017-10-18 20:18:43.004182Z] Running run-tests step. 13:18:43 INFO - Running pre-action listener: _resource_record_pre_action 13:18:43 INFO - Running pre-action listener: _set_gcov_prefix 13:18:43 INFO - Running main action method: run_tests 13:18:43 WARNING - Try message not found. 13:18:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:18:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:18:43 INFO - Python 2.7.3 13:18:43 INFO - Return code: 0 13:18:43 INFO - grabbing minidump binary from tooltool 13:18: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')]} 13:18:43 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 0x2560090>, '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 0x2560d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255af90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:18:43 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 13:18:43 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 13:18:43 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 13:18:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:18:43 INFO - Return code: 0 13:18:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:18:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:18:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:18:43 INFO - ENV: RUST_BACKTRACE is now full 13:18:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:18:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:18:43 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/DxSyuDGrTnqOFaD84cZ-Pg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 13:18:43 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/DxSyuDGrTnqOFaD84cZ-Pg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-027 --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 13:18:43 INFO - Using env: {'DISPLAY': ':0', 13:18:43 INFO - 'HOME': '/home/cltbld', 13:18:43 INFO - 'LANG': 'en_US.UTF-8', 13:18:43 INFO - 'LANGUAGE': 'en_US:en', 13:18:43 INFO - 'LOGNAME': 'cltbld', 13:18:43 INFO - 'MAIL': '/var/mail/cltbld', 13:18:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:18:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:18:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:18:43 INFO - 'MOZ_NO_REMOTE': '1', 13:18:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:18:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:18:43 INFO - 'NO_EM_RESTART': '1', 13:18:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:18:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:18:43 INFO - 'PWD': '/builds/slave/test', 13:18:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:18:43 INFO - 'RUST_BACKTRACE': 'full', 13:18:43 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 13:18:43 INFO - 'SHELL': '/bin/bash', 13:18:43 INFO - 'SHLVL': '1', 13:18:43 INFO - 'TERM': 'linux', 13:18:43 INFO - 'TMOUT': '86400', 13:18:43 INFO - 'USER': 'cltbld', 13:18:43 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1508357863.551163-558148248', 13:18:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:18:43 INFO - '_': '/tools/buildbot/bin/python'} 13:18:43 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/DxSyuDGrTnqOFaD84cZ-Pg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 13:18:43 INFO - mozversion application_buildid: 20171018185959 13:18:43 INFO - mozversion application_changeset: d4e212a2b1e1180c245dd528c39500991de311ad 13:18:43 INFO - mozversion application_display_name: Firefox 13:18:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:18:43 INFO - mozversion application_name: Firefox 13:18:43 INFO - mozversion application_remotingname: firefox 13:18:43 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 13:18:43 INFO - mozversion application_vendor: Mozilla 13:18:43 INFO - mozversion application_version: 57.0 13:18:43 INFO - mozversion platform_buildid: 20171018185959 13:18:43 INFO - mozversion platform_changeset: d4e212a2b1e1180c245dd528c39500991de311ad 13:18:43 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 13:18:43 INFO - mozversion platform_version: 57.0 13:18:43 INFO - using testdate: 1508357923 13:18:43 INFO - actual date: 1508357923 13:18:43 INFO - starting webserver on 'localhost:38438' 13:18:43 INFO - SUITE-START | Running 2 tests 13:18:43 INFO - TEST-START | dromaeo_css 13:18:43 INFO - Initialising browser for dromaeo_css test... 13:18:43 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:38438/getInfo.html -profile /tmp/tmpaFZxq2/profile 13:18:43 INFO - TEST-INFO | started process 11475 (/builds/slave/test/build/application/firefox/firefox http://localhost:38438/getInfo.html) 13:18:48 INFO - TEST-INFO | 11475: exit 0 13:18:48 INFO - Browser initialized. 13:18:48 INFO - Running cycle 1/1 for dromaeo_css test... 13:18:48 INFO - Using env: {'DISPLAY': ':0', 13:18:48 INFO - 'HOME': '/home/cltbld', 13:18:48 INFO - 'JSGC_DISABLE_POISONING': '1', 13:18:48 INFO - 'LANG': 'en_US.UTF-8', 13:18:48 INFO - 'LANGUAGE': 'en_US:en', 13:18:48 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 13:18:48 INFO - 'LOGNAME': 'cltbld', 13:18:48 INFO - 'MAIL': '/var/mail/cltbld', 13:18:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:18:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:18:48 INFO - 'MOZ_CRASHREPORTER': '1', 13:18:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:18:48 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 13:18:48 INFO - 'MOZ_NO_REMOTE': '1', 13:18:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:18:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:18:48 INFO - 'NO_EM_RESTART': '1', 13:18:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:18:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:18:48 INFO - 'PWD': '/builds/slave/test', 13:18:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:18:48 INFO - 'RUST_BACKTRACE': 'full', 13:18:48 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 13:18:48 INFO - 'SHELL': '/bin/bash', 13:18:48 INFO - 'SHLVL': '1', 13:18:48 INFO - 'TERM': 'linux', 13:18:48 INFO - 'TMOUT': '86400', 13:18:48 INFO - 'USER': 'cltbld', 13:18:48 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1508357863.551163-558148248', 13:18:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:18:48 INFO - '_': '/tools/buildbot/bin/python'} 13:18:48 INFO - TEST-INFO | started process 11705 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaFZxq2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 13:18:49 INFO - PID 11705 | 13:18:49 INFO - PID 11705 | (/builds/slave/test/build/application/firefox/firefox:11753): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 13:18:49 INFO - PID 11705 | 13:18:59 INFO - PID 11705 | RSS: Main: 143618048 13:18:59 INFO - PID 11705 | 13:21:56 INFO - PID 11705 | Cycle 1(1): loaded http://localhost:38438/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38438/tests/dromaeo/cssquery-ext.html) 13:21:57 INFO - PID 11705 | RSS: Main: 146640896 13:21:57 INFO - PID 11705 | 13:24:58 INFO - PID 11705 | Cycle 1(1): loaded http://localhost:38438/tests/dromaeo/cssquery-ext.html (next: http://localhost:38438/tests/dromaeo/cssquery-jquery.html) 13:24:59 INFO - PID 11705 | RSS: Main: 144789504 13:24:59 INFO - PID 11705 | 13:28:00 INFO - PID 11705 | Cycle 1(1): loaded http://localhost:38438/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38438/tests/dromaeo/cssquery-mootools.html) 13:28:01 INFO - PID 11705 | RSS: Main: 146137088 13:28:01 INFO - PID 11705 | 13:31:02 INFO - PID 11705 | Cycle 1(1): loaded http://localhost:38438/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38438/tests/dromaeo/cssquery-prototype.html) 13:31:03 INFO - PID 11705 | RSS: Main: 146264064 13:31:03 INFO - PID 11705 | 13:34:06 INFO - PID 11705 | Cycle 1(1): loaded http://localhost:38438/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38438/tests/dromaeo/cssquery-yui.html) 13:34:06 INFO - PID 11705 | RSS: Main: 147845120 13:34:06 INFO - PID 11705 | 13:37:08 INFO - PID 11705 | Cycle 1(1): loaded http://localhost:38438/tests/dromaeo/cssquery-yui.html (next: http://localhost:38438/tests/dromaeo/cssquery-dojo.html) 13:37:08 INFO - PID 11705 | RSS: Main: 150159360 13:37:08 INFO - PID 11705 | 13:37:08 INFO - PID 11705 | __start_tp_report 13:37:08 INFO - PID 11705 | _x_x_mozilla_page_load 13:37:08 INFO - PID 11705 | _x_x_mozilla_page_load_details 13:37:08 INFO - PID 11705 | |i|pagename|runs| 13:37:08 INFO - PID 11705 | |0;dojo.html;3966.305896468118;3981.3231750602395;3992.960070399295;4011.7793521356316;4012.478377810882;6312.747490100396;6338.207724034496;6358.491320694345;6379.617222966619;6430.710618022183;6388.297287298405;6402.359764023596;6447.129637498936;6475.255345635253;6482.96758516208;5744.195812586252;5755.338136114358;5805.332386775512;5827.125931110346;5846.356900740915;5802.303723553179;5810.854728631776;5815.273090863642;5836.445537673914;5872.5889187756875;5802.506786923117;5835.4164583541515;5840.3575606683235;5863.882722345551;5875.823725288227;5673.716314184274;5765.365809760902;5816;5819.505342045889;5844.503217226541;5630.380658127644;5673.773049078032;5702.714864256812;5708.743106560215;5734;6265.498760099181;6281.59169653971;6323.7786677466065;6342.365763423621;6352.1742173517605;6756.4932630052945;6833.931660683379;6844.623545704984;6872.484563657746;6877.828054298632;6822.181338239443;6822.624755638438;6837.589744615289;6900.723971041152;6923.238443771181;6172.382761723837;6248.375162483715;6308.211473565759;6323.05154226865;6367.363263673642;7156.570605763567;7173.5337203081635;7196.172440169343;7196.964015179995;7199;6800.965995170091;6817.590944543244;6820;6874.931250687529;6887.827804304932;6837.384635382839;6870.141232345957;6933.375996160269;6967.79096627102;7067.89398159028;6783.59298442095;6845.452363810883;6861.622610756356;6875.965620171867;6879.449644028466;6754.18949726036;6759.324067593299;6857.828554286083;6865.725370985205;6884.242733299333;5006.249062640633;5068.189089745697;5086.033653605803;5088.1350170471105;5097.6941383517105;4596.724196548218;4642.326862604903;4651.046535460223;4662.7668616569035;4675.018246168274;6383.170187875547;6401.871962560723;6444.7744328948265;6493.8701225976165;6496.902546461807;6851.657417129124;6855.691493882788;6917.412019978257;6917.654117294115;6920.377166055079;6480.125183100221;6483.481321494269;6512.804615861532;6535.57518761279;6536.24833144185;5733.741981610838;5743.569232307594;5776.104703770922;5785.4793068623185;5814.796482123105;7042.542234754725;7226.096737907762;7237.565746055254;7328.853422931512;7332.30343117403;6795.864082718318;6822.897656535255;6856.691448884912;6910.239873613999;6928.7228510859;7194.388476979515;7254.492185546961;7326.743563975236;7348.375388091858;7356.190819009797;6848.863022739418;6849.1096157499205;6912.308769123048;6927.618980956096;6929.480288978246;6849.31506849331;6883.552569082994;6887.690053947485;6992.825179370557;7016.964915175391;6591.274959754327;6634.734610615521;6709.161354830646;6712.516368943327;6751.189857217166;6598.3401659833635;6645;6680.298568650222;6682.565633233824;6702.497312701469;6577.80266592003;6586.176727909012;6668.83327916806;6669.966650166718;6676.899846502403;6501.2523559791225;6530.8040758777315;6569;6679.265280819203;6719.395254427125;6467.482601391784;6534.411902928759;6540.672966351568;6550.967245163934;6569.408753212043 13:37:08 INFO - PID 11705 | |1;ext.html;991.4002028772593;1013.7820368620747;1040.1886528507766;1046.487221261582;1049.3231865446787;43707.78146109269;46143.769281153545;46576.06847863045;46711.53288467114;46794.766026169906;43621.345679814825;46823.765881170635;47464.525354746445;47483.0503389932;47607.761961190234;7497.962510187455;7514.736984205554;7530.359919406829;7539.736109236151;7548.5093468924615;7759.728409505668;7864.488808227476;7878.330341920943;7898.210178982114;7915.1689072647405;7844.254795794419;7935.285824275814;7936.920630793705;7938.563379014152;7956.602169891511;7886.526808391515;7926.28663420292;7939.4839335443585;7943.761687149395;7945.721899733539;8061.274485296293;8093.676252949875;8097.716579919675;8110.148434414361;8113.269805717455;42579.57420425818;42933.78533107346;43001.35497967533;43034.56965430337;43069.35395969063;3813.637704418076;3868.303705333039;3870.767753934773;3873.786941718204;3875.5155605549307;34904.82547587271;34940.126496837525;35175.648243517746;35358.292834143176;35359.4696079559;5655.604107712462;5676.290463692038;5691.544676425876;5692.146178073281;5814.47669709724;235550;239809;241239;241618;256947.99999999814;57047.14429283564;57114.714426428436;57652.42347576554;57741.4225857736;57826;59051.40948590545;59179.70410147922;59202.70398648065;59220;59451.405485945455;17357;17432.82567174312;17503;17507.824921750875;17518.649627007642;14138.717225655635;14141.7979471744;14153.787693184611;14166.079204851652;14172.787408188886;15120.621984450258;15286.464973725866;15354.385824566893;15376.615584610474;15450;5706.914396284059;5825.50483208932;5897.528197744256;5980.611260268069;6000.669963151981;1089.4117176724637;1110.7611863449235;1131.7623299107115;1133.5409159290336;1143.4511434511314;25984.836778538043;26319.34201644974;26343;26583.73416265851;26743;1233.3956361383036;1236.048242852998;1236.6042866282703;1240.7952687806592;1254.7176885200756;13702.314884255748;13797.310134493235;13858.792118118236;13869.09850859691;14121.85878141226;289069;294916;298360;300488;306393;64771.67614161899;64790.35209647843;65111;65244;65408.67295663586;1522.2997421186158;1528.4879565345511;1539.1303913288955;1550.9844901551292;1589.5469791109479;30415.847920760254;31100.377992440477;31378;31661;31915.202119947186;43859.34210986774;44015;44051.118977619626;44073.11853762971;44416.777916110215;255311;255805;256869;257233;257806;37203.441948371335;37792.62207377891;38047.04882377962;38108.42837357497;38301;48165.75917120392;48939.265911010654;49045.75477122592;49259.75370123127;49366.25950610815;35206.47190292199;35384.29231415409;36422.27155456929;36570.45144322784;36572.45141322829;35202.29595408026;35636.821815890755;35683.64316356907;35841.82079089588;36365.72719954895;41559.58440415557;41667.1666566673;41807.790961045;42154.36768448415;42236.78881605572;34458.82770586131;34831.12922176966;34961.30077398387;35112.64887351094;35454.8227258862;25822.741772582034;25853.482930341663;26015;26564;26641.33396665099 13:37:08 INFO - PID 11705 | |2;jquery.html;621.6083867163686;632;638.1416994142876;639.2201514152734;644.2365796531111;24039.278821635336;24309.513809723838;24824.255272341838;24899.253022409335;25603.359916002108;27649.170524884234;28100.859495702494;28108.859455702743;28129.29676758082;28132.437351253015;6773.4919881009;6878.312168783132;6915.827104322382;6915.965420172917;6939.895901561481;6562.770303039395;6931.896021559681;6940.167179938415;6961.269066747995;6962.756303529378;6873.690683919211;6878.587284762905;6910.101686780711;6910.619915904624;6930.896036559456;6798.116244888133;6864.279250678656;6882.587044777304;6888.827779305508;6895.965520172417;6389.648569328685;6396.840078998062;6418.19772528434;6432.292447830735;6434.163558737381;31889.521657175163;32029.83985080083;32838.83580582106;32870.178245543815;32978.17554561131;2355.5759963206615;2408.6025805742033;2414.9034038638433;2416.891239894209;2417.9965314394503;21081.47296317589;21426.46433839151;21576.784232157635;21615.243466478754;21632;2489.7136829264505;2642.6036094585775;2647.430802377479;2650.9204723858315;2657.694365147994;146494;153305;160889.19555402265;165684.17157914134;166911;16579.68406318741;16965.830341696674;16976.320947161974;17066.31734730597;17362.305507779547;27371.31571710723;27387;27479.587806182924;27524.311892202855;27531.17406477809;11575.536978520933;11715.062794976382;11739.23694959842;11746.765064698659;11787.941060294643;10629.893701063045;10634.096101831276;10643.893561064446;10731.731706707395;10792.568297268179;10486.26596138263;10515.789684206273;10713.303635263683;10714.196435267386;10758.300710453796;2986.25343664084;3005;3037.9544306835414;3058.128433396516;3090.5673205751214;1058.5977328615077;1064.356064580933;1066.7546464313252;1069.9304545204536;1077.283606401734;22130.668039979413;22553.66169507459;22698.886505567367;22797.202097926493;22953.540929181323;1153.7346410325672;1159.3623507071077;1173.3487914207697;1177.1230433327225;1182.5506307603227;12305.50777968889;12370.62888113358;12537.122401431994;12539.811902821464;12546.874531254753;596048;613058;616243;648066;652963;134865;136433;138288;139553;140000;1135.7558125003;1277.8530468996184;1293.8512071111943;1297.7469393468184;1309.4107651556837;23137.537249254583;23522;23549.175778848345;23790.881045595353;23864.761352386253;65644.38008688233;65979;66155.33844661491;66209.33790662032;67151;79842.20157798348;81240;83186;83571.16428835878;84780;16360.34558617642;16538.09040502784;16541.66916661684;16582.66834663276;16638.16809159513;24657.63013554834;25020.312741447404;25552.361190970376;25600.61599075978;25768.226953191435;20128.698069528677;20262.59474810525;20410.081546330155;20544.486387840425;20707;18427.90786046115;18493.72259416137;18592.977386243347;18903.810961890205;19068.8093119067;20905.37283881425;20950.161993520698;20959.37121886346;21054.894725526276;21256.25603103884;16238.269277882287;16301.347946082498;16343;16394.426195083113;16571;19841.206351746347;20090.29683961113;20130.295439660127;20493.38519844407;20836.895815520824 13:37:08 INFO - PID 11705 | |3;mootools.html;1446.2190417174725;1468.552091612058;1488.2558720639681;1500.1074360755347;1504.774283857422;17790.73313900291;18518.722219166724;18524.629507409845;18544.165512551936;18544.701870869045;18116.547086322847;18123.45629631113;18197.636047279047;18229.0885455727;18231.908840455813;3088.289693370526;3126.40598286326;3148.2129467632976;3151.763617728668;3164.351307981858;3033.8179709217516;3087.783855130142;3103.3948380065895;3105.1305634422283;3105.2081719161583;3056.0373482353098;3066.0955018269665;3078.9230269243335;3079.214800225939;3080.3531258435755;2927.838968856712;2936.6916473770266;2953.1583498702876;2953.8479992802822;2953.911382658502;2859.7140285971445;2872.3680790226117;2877.49643812332;2886.7401933825845;2888.638920134983;17003.149842507948;17199.398021069326;17316.56708582283;17353.913230433893;17385.1307434629;8864.645414183426;9196.218321442686;9198.494082825442;9199.678011269574;9204.171624553823;6040.184575082351;6153.692315384257;6254.843628909313;6311.147995020659;6312.116303717483;2151.3868547464053;2181.9236326728646;2211.458192742772;2264.852784568998;2276.2147059264526;30157.436617887506;31114.844425777952;32597.51103733422;33549.16127096842;33680.32639347224;8174.38692098095;8280.254777070093;8292.17078292166;8532.104129066358;8556.786080347916;25039.12363067284;25042.248732538053;25068.122615708362;25133.87433062823;25148.74851251464;9642.614295428104;9717.514124293757;9721.611135554498;9770.706878793506;9788.363756355957;8416.4950102994;8425.157484251526;8601.31189504838;8650.178233067974;8681.262092722063;6496.447801936888;6508.088867558546;6521.771737989147;6560.507961902877;6637.402633762985;1948.9925376861854;1949.132635977005;1957.471482699663;1964.72493850861;1976.6244413561378;956.5791051937125;969.8060387922444;969.8787651543557;974.4348277998744;981.8183636027358;8719.738407847775;9019.864702029476;9028.63885444588;9080;9094.226990705863;805.9194080592011;818.5088946632093;820.2699597358355;824.7690646618956;825.7398919340388;4919.163742163841;4973.278874563241;4979.377577802775;4995.825146119869;5001.549860512571;25250.747492525206;26658.333541661224;26727.732722672914;26878.731212688013;26978.055768048023;26429.207123786317;26550.734492654825;26719.866400667874;26731.33171670724;27112;12490.812637810259;12513.249205047727;12533.623991280276;12589.24464532131;12589.622311330491;9079.909200907907;9183.77040573991;9221.677241296522;9257.814843702954;9312.906870931474;21878.562428751018;22332.88833555822;22431.77568224297;22531.324060277562;22664.320070397913;23330.300090997298;23776.88111559431;23924.401889952194;24000.51998960046;24271.271861844172;14186.645333866736;14274.857251427768;14408.567742967727;14413.279336032947;14436.783448248074;16212.10833404174;16217.51347459578;16294.266757995681;16499.010059396474;16565.503034908972;13066.934665326613;13069.738605228033;13103.803442948554;13268.071235013456;13299.401526931504;12796.808047879103;12992.675183120498;13173.802392964304;13307.46770129184;13313.46746130144;11436.085113190758;11677.76644467123;11756.588519402121;11759;11760.588379407021;8248.711295104642;8371.079181289932;8455.365847561581;8548.658053677784;8599.699010534601;8005.759827205193;8089.150639182801;8195.549244791355;8208.958955205186;8243.917560824315 13:37:08 INFO - PID 11705 | |4;prototype.html;550.3863192540318;582.3303201318481;595.9284885813697;596.4542443664046;601.8645804693945;6162.59943103698;6181.752729890799;6187.627742880124;6198.814035578928;6203.379662033794;6070.817875463732;6121.173641558388;6122.326544080148;6140.8464788380315;6148.631082135075;5016.570277470922;5043.226225575937;5103.387593488777;5104.719240441774;5107.872303192413;4816.686915350491;4916.139675556781;5045.72028181683;5125.615578831584;5131.640785145041;4917.385326834145;4940.876478088041;4962.875928101808;4974.477679843619;4978.900421991558;4878.0975519529;4907.9263811042865;4942.851714448572;4945.703257804544;4959.330490383788;4477.6417886569;4517.909641807146;4522.525134860825;4536.614387777043;4540.931886021713;6034.728437220336;6055.2430946131735;6065.60573562717;6081.756729730805;6081.939180608226;5778.566607504454;5796.304443466811;5816.767329306823;5828.242328497311;5830.504407125357;6450.677466126722;6466.612003279818;6498.577592456475;6505.837354066139;6511.186101737283;4806.110869489155;4985.675931064506;4989.301497790312;4998.500149985009;5017.77064619167;6532.836679083013;6686.866262674719;6767.830804229884;6772.458203343721;6790.898136527907;5104.489551044866;5104.617153713486;5175.896482070338;5192.273081768555;5199.428062913076;5205.375354957429;5245.423003469616;5256.894862102737;5258.3689957204615;5284;5725.625849796019;5744.626599271034;5767.452092051332;5815.255423373056;5817.156512305776;6496.083655321691;6533.738650454024;6546.214454265423;6546.8363290918105;6613.86772264552;1790.409164975581;1792.8207179281967;1804.927802887896;1813.909304534768;1815.3464752689022;1253.7587788089909;1301.466398776497;1306.5623016289649;1310;1311.9803202951964;5605.8598535036135;6155.446009859044;6179.0535981165785;6202.255729312511;6217.6891155442045;6483.675816209265;6499.5775274607;6531.354801305479;6557.344265573404;6574.868502630016;6117.449429551273;6137.9079313810325;6148.907766383508;6171;6188;3469.739769517246;3478.1826270826336;3483.512308276843;3503.211777350076;3512.438009918401;6882.139732533434;6884.139482564679;6904.997550710338;6914.446844252448;7001.544899581511;6609.966950165219;6639.468842492685;6693.397594216543;6729.764458243938;6758.560693554903;6769;6838.48711346651;6891.3797758202;6898.793036208922;6902.654867256517;6566;6600.207975043026;6603.636799976048;6612.603243805194;6621.370969757865;6548.692910080379;6570.342965703582;6585.3085426029575;6612.801615951529;6617.205935287604;6950.304969503211;6968.930310696828;6988.37104660583;7006.369426751617;7015.298470152944;5181.792728290826;5215.322008138917;5230.398504172069;5230.921536177037;5242.449542797951;6371.331010243857;6447.451966582893;6541.8037458874405;6561.704723287368;6705.765298214539;6109.175261339662;6258.593191442542;6291.7035282122615;6336.366363363627;6399.7440102395385;6295.748170073146;6323.652199129092;6376.234851817811;6394.200724909387;6394.23269207698;6290.495816160859;6293.716782744879;6322.26986078216;6373.171487706569;6416.7754128605275;6336.493080553452;6357.8728425432155;6398.776042838478;6474.446132928158;6492.38322359394;6252.187215661935;6268.27914789805;6269.592476489013;6294.402031806971;6345.8730825384155 13:37:08 INFO - PID 11705 | |5;yui.html;979.8481235408514;1010.3887148275292;1031.3708637730988;1033.0650761061238;1042.5933885784546;20788.480287992807;21080.472988175265;21157;21253;21326.573468530638;18922;19002.80997190028;20387.59224815503;20562.89718551405;20693;1068.2895874243638;1084.138110202387;1084.1868598551087;1084.230196560439;1084.2735367303926;1070.8929107089268;1113.2541197397763;1114.8717897441777;1115.7043383503378;1116.4250411038322;1169.6958790714432;1190.2917763930448;1190.672565044611;1191.410251925298;1191.8212268159803;1177.8881006304387;1180.1267062373868;1181.1141643767176;1185.2118341303023;1185.6857932647856;859.4456575508824;867.1155421470128;868.2229404682837;871.4422769427572;871.6382701179003;21424.571508569898;21950.560988780293;22205.77794222053;22293.331200064025;22322.665160022614;23514.882425587763;23589.764102358928;23998.280051598307;24079;24081.759182408303;17881.552961175945;17959.820401795947;17966.550836229067;18021.27914883416;18132.274709011625;3995.840166393341;4017.97991010046;4062.8171732272117;4071.2671719090554;4073.816678249486;165488;169356;170904;171338;172664.13667931705;18034.27862885496;18313.084345782656;18379.81620183808;18382.264709411473;18398.724019139725;34303.4854477183;34863.12842178915;34894;34990.30019399649;35023.29953400969;8308.626111824982;8490.702825401082;8633.69782057625;8646;8652.913470865336;4188.790560471964;4257.936130958038;4258.53156152823;4264.104538046983;4286.807093680792;6192.164057852222;6251.437370636664;6289.96855015722;6314.778982735582;6330.8100756977365;1157.9826302605468;1173.6655053309767;1182.3142577305143;1190.9166358355005;1194.0865238092865;736.0872518077653;747.196763479262;751.1887161865172;759.6239861268707;775.3487070860391;13124.212547247196;13246.73506529864;13388.263645499592;14007.098394125474;14358.856411435752;716.3230746944192;717.3615482220828;717.6340066566089;724.2069933422998;727.752564128199;5881.735321910524;5903.1145328200255;6071;6073.240844894388;6075.969620151871;150553;152964;154111;155572;156308.21845890925;128045;128947;129674;130065;133584;115122.42438787753;116284.04484497788;116982;118271;120649.39675301567;13385.330733463483;13971.860281397056;14018.158910465405;14068.437262509386;14116.717665646423;57509.712451437474;57615.50998370185;58129.709351454665;58311.416885832296;58924.41075589189;71760.28239717535;72245.63877180581;72804.18856505923;74246.62876685798;75055;20578.691319630518;20773.79226207779;20795.480112997295;20959;21034;20898.37304880856;21553.137874484844;21602.783972160076;21618.567628647026;21695.240666576596;20631.484212894797;20809;20849.270275540282;20862.374128776162;20893.582128357044;18815.15331810099;18818.905905470387;19012.619747604695;19062.237510499424;19079.71380429267;18345.72481412753;18414.17136228846;18582.070896455392;18597.256109755457;18991.620167596848;14094.36575354132;14616;14695.691247690678;14757.409703611735;14782.556523304318;14526.927365363106;14679.266036698336;14689.92655036718;14837.33232004584;14906.180160090866 13:37:08 INFO - PID 11705 | __end_tp_report 13:37:08 INFO - PID 11705 | __start_cc_report 13:37:08 INFO - PID 11705 | _x_x_mozilla_cycle_collect,255 13:37:08 INFO - PID 11705 | __end_cc_report 13:37:08 INFO - PID 11705 | __startTimestamp1508359028453__endTimestamp 13:37:08 INFO - PID 11705 | 13:37:08 INFO - PID 11705 | ------- Summary: start ------- 13:37:08 INFO - PID 11705 | Number of tests: 6 13:37:08 INFO - PID 11705 | 13:37:08 INFO - PID 11705 | [#0] dojo.html Cycles:165 Average:6373.31 Median:6569.41 stddev:733.21 (11.2%) stddev-sans-first:710.73 13:37:08 INFO - PID 11705 | Values: 3966.3 3981.3 3993.0 4011.8 4012.5 6312.7 6338.2 6358.5 6379.6 6430.7 6388.3 6402.4 6447.1 6475.3 6483.0 5744.2 5755.3 5805.3 5827.1 5846.4 5802.3 5810.9 5815.3 5836.4 5872.6 5802.5 5835.4 5840.4 5863.9 5875.8 5673.7 5765.4 5816.0 5819.5 5844.5 5630.4 5673.8 5702.7 5708.7 5734.0 6265.5 6281.6 6323.8 6342.4 6352.2 6756.5 6833.9 6844.6 6872.5 6877.8 6822.2 6822.6 6837.6 6900.7 6923.2 6172.4 6248.4 6308.2 6323.1 6367.4 7156.6 7173.5 7196.2 7197.0 7199.0 6801.0 6817.6 6820.0 6874.9 6887.8 6837.4 6870.1 6933.4 6967.8 7067.9 6783.6 6845.5 6861.6 6876.0 6879.4 6754.2 6759.3 6857.8 6865.7 6884.2 5006.2 5068.2 5086.0 5088.1 5097.7 4596.7 4642.3 4651.0 4662.8 4675.0 6383.2 6401.9 6444.8 6493.9 6496.9 6851.7 6855.7 6917.4 6917.7 6920.4 6480.1 6483.5 6512.8 6535.6 6536.2 5733.7 5743.6 5776.1 5785.5 5814.8 7042.5 7226.1 7237.6 7328.9 7332.3 6795.9 6822.9 6856.7 6910.2 6928.7 7194.4 7254.5 7326.7 7348.4 7356.2 6848.9 6849.1 6912.3 6927.6 6929.5 6849.3 6883.6 6887.7 6992.8 7017.0 6591.3 6634.7 6709.2 6712.5 6751.2 6598.3 6645.0 6680.3 6682.6 6702.5 6577.8 6586.2 6668.8 6670.0 6676.9 6501.3 6530.8 6569.0 6679.3 6719.4 6467.5 6534.4 6540.7 6551.0 6569.4 13:37:08 INFO - PID 11705 | 13:37:08 INFO - PID 11705 | [#1] ext.html Cycles:180 Average:45384.81 Median:37919.84 stddev:69513.79 (183.3%) stddev-sans-first:69628.87 13:37:08 INFO - PID 11705 | Values: 991.4 1013.8 1040.2 1046.5 1049.3 43707.8 46143.8 46576.1 46711.5 46794.8 43621.3 46823.8 47464.5 47483.1 47607.8 7498.0 7514.7 7530.4 7539.7 7548.5 7759.7 7864.5 7878.3 7898.2 7915.2 7844.3 7935.3 7936.9 7938.6 7956.6 7886.5 7926.3 7939.5 7943.8 7945.7 8061.3 8093.7 8097.7 8110.1 8113.3 42579.6 42933.8 43001.4 43034.6 43069.4 3813.6 3868.3 3870.8 3873.8 3875.5 34904.8 34940.1 35175.6 35358.3 35359.5 5655.6 5676.3 5691.5 5692.1 5814.5 235550.0 239809.0 241239.0 241618.0 256948.0 57047.1 57114.7 57652.4 57741.4 57826.0 59051.4 59179.7 59202.7 59220.0 59451.4 17357.0 17432.8 17503.0 17507.8 17518.6 14138.7 14141.8 14153.8 14166.1 14172.8 15120.6 15286.5 15354.4 15376.6 15450.0 5706.9 5825.5 5897.5 5980.6 6000.7 1089.4 1110.8 1131.8 1133.5 1143.5 25984.8 26319.3 26343.0 26583.7 26743.0 1233.4 1236.0 1236.6 1240.8 1254.7 13702.3 13797.3 13858.8 13869.1 14121.9 289069.0 294916.0 298360.0 300488.0 306393.0 64771.7 64790.4 65111.0 65244.0 65408.7 1522.3 1528.5 1539.1 1551.0 1589.5 30415.8 31100.4 31378.0 31661.0 31915.2 43859.3 44015.0 44051.1 44073.1 44416.8 255311.0 255805.0 256869.0 257233.0 257806.0 37203.4 37792.6 38047.0 38108.4 38301.0 48165.8 48939.3 49045.8 49259.8 49366.3 35206.5 35384.3 36422.3 36570.5 36572.5 35202.3 35636.8 35683.6 35841.8 36365.7 41559.6 41667.2 41807.8 42154.4 42236.8 34458.8 34831.1 34961.3 35112.6 35454.8 25822.7 25853.5 26015.0 26564.0 26641.3 13:37:08 INFO - PID 11705 | 13:37:08 INFO - PID 11705 | [#2] jquery.html Cycles:180 Average:41615.71 Median:23329.77 stddev:104792.15 (449.2%) stddev-sans-first:105040.92 13:37:08 INFO - PID 11705 | Values: 621.6 632.0 638.1 639.2 644.2 24039.3 24309.5 24824.3 24899.3 25603.4 27649.2 28100.9 28108.9 28129.3 28132.4 6773.5 6878.3 6915.8 6916.0 6939.9 6562.8 6931.9 6940.2 6961.3 6962.8 6873.7 6878.6 6910.1 6910.6 6930.9 6798.1 6864.3 6882.6 6888.8 6896.0 6389.6 6396.8 6418.2 6432.3 6434.2 31889.5 32029.8 32838.8 32870.2 32978.2 2355.6 2408.6 2414.9 2416.9 2418.0 21081.5 21426.5 21576.8 21615.2 21632.0 2489.7 2642.6 2647.4 2650.9 2657.7 146494.0 153305.0 160889.2 165684.2 166911.0 16579.7 16965.8 16976.3 17066.3 17362.3 27371.3 27387.0 27479.6 27524.3 27531.2 11575.5 11715.1 11739.2 11746.8 11787.9 10629.9 10634.1 10643.9 10731.7 10792.6 10486.3 10515.8 10713.3 10714.2 10758.3 2986.3 3005.0 3038.0 3058.1 3090.6 1058.6 1064.4 1066.8 1069.9 1077.3 22130.7 22553.7 22698.9 22797.2 22953.5 1153.7 1159.4 1173.3 1177.1 1182.6 12305.5 12370.6 12537.1 12539.8 12546.9 596048.0 613058.0 616243.0 648066.0 652963.0 134865.0 136433.0 138288.0 139553.0 140000.0 1135.8 1277.9 1293.9 1297.7 1309.4 23137.5 23522.0 23549.2 23790.9 23864.8 65644.4 65979.0 66155.3 66209.3 67151.0 79842.2 81240.0 83186.0 83571.2 84780.0 16360.3 16538.1 16541.7 16582.7 16638.2 24657.6 25020.3 25552.4 25600.6 25768.2 20128.7 20262.6 20410.1 20544.5 20707.0 18427.9 18493.7 18593.0 18903.8 19068.8 20905.4 20950.2 20959.4 21054.9 21256.3 16238.3 16301.3 16343.0 16394.4 16571.0 19841.2 20090.3 20130.3 20493.4 20836.9 13:37:08 INFO - PID 11705 | 13:37:08 INFO - PID 11705 | [#3] mootools.html Cycles:180 Average:11184.26 Median:2932.27 stddev:8389.71 (286.1%) stddev-sans-first:8381.35 13:37:08 INFO - PID 11705 | Values: 1446.2 1468.6 1488.3 1500.1 1504.8 17790.7 18518.7 18524.6 18544.2 18544.7 18116.5 18123.5 18197.6 18229.1 18231.9 3088.3 3126.4 3148.2 3151.8 3164.4 3033.8 3087.8 3103.4 3105.1 3105.2 3056.0 3066.1 3078.9 3079.2 3080.4 2927.8 2936.7 2953.2 2953.8 2953.9 2859.7 2872.4 2877.5 2886.7 2888.6 17003.1 17199.4 17316.6 17353.9 17385.1 8864.6 9196.2 9198.5 9199.7 9204.2 6040.2 6153.7 6254.8 6311.1 6312.1 2151.4 2181.9 2211.5 2264.9 2276.2 30157.4 31114.8 32597.5 33549.2 33680.3 8174.4 8280.3 8292.2 8532.1 8556.8 25039.1 25042.2 25068.1 25133.9 25148.7 9642.6 9717.5 9721.6 9770.7 9788.4 8416.5 8425.2 8601.3 8650.2 8681.3 6496.4 6508.1 6521.8 6560.5 6637.4 1949.0 1949.1 1957.5 1964.7 1976.6 956.6 969.8 969.9 974.4 981.8 8719.7 9019.9 9028.6 9080.0 9094.2 805.9 818.5 820.3 824.8 825.7 4919.2 4973.3 4979.4 4995.8 5001.5 25250.7 26658.3 26727.7 26878.7 26978.1 26429.2 26550.7 26719.9 26731.3 27112.0 12490.8 12513.2 12533.6 12589.2 12589.6 9079.9 9183.8 9221.7 9257.8 9312.9 21878.6 22332.9 22431.8 22531.3 22664.3 23330.3 23776.9 23924.4 24000.5 24271.3 14186.6 14274.9 14408.6 14413.3 14436.8 16212.1 16217.5 16294.3 16499.0 16565.5 13066.9 13069.7 13103.8 13268.1 13299.4 12796.8 12992.7 13173.8 13307.5 13313.5 11436.1 11677.8 11756.6 11759.0 11760.6 8248.7 8371.1 8455.4 8548.7 8599.7 8005.8 8089.2 8195.5 8209.0 8243.9 13:37:08 INFO - PID 11705 | 13:37:08 INFO - PID 11705 | [#4] prototype.html Cycles:180 Average:5542.58 Median:6159.02 stddev:1525.14 (24.8%) stddev-sans-first:1482.67 13:37:08 INFO - PID 11705 | Values: 550.4 582.3 595.9 596.5 601.9 6162.6 6181.8 6187.6 6198.8 6203.4 6070.8 6121.2 6122.3 6140.8 6148.6 5016.6 5043.2 5103.4 5104.7 5107.9 4816.7 4916.1 5045.7 5125.6 5131.6 4917.4 4940.9 4962.9 4974.5 4978.9 4878.1 4907.9 4942.9 4945.7 4959.3 4477.6 4517.9 4522.5 4536.6 4540.9 6034.7 6055.2 6065.6 6081.8 6081.9 5778.6 5796.3 5816.8 5828.2 5830.5 6450.7 6466.6 6498.6 6505.8 6511.2 4806.1 4985.7 4989.3 4998.5 5017.8 6532.8 6686.9 6767.8 6772.5 6790.9 5104.5 5104.6 5175.9 5192.3 5199.4 5205.4 5245.4 5256.9 5258.4 5284.0 5725.6 5744.6 5767.5 5815.3 5817.2 6496.1 6533.7 6546.2 6546.8 6613.9 1790.4 1792.8 1804.9 1813.9 1815.3 1253.8 1301.5 1306.6 1310.0 1312.0 5605.9 6155.4 6179.1 6202.3 6217.7 6483.7 6499.6 6531.4 6557.3 6574.9 6117.4 6137.9 6148.9 6171.0 6188.0 3469.7 3478.2 3483.5 3503.2 3512.4 6882.1 6884.1 6905.0 6914.4 7001.5 6610.0 6639.5 6693.4 6729.8 6758.6 6769.0 6838.5 6891.4 6898.8 6902.7 6566.0 6600.2 6603.6 6612.6 6621.4 6548.7 6570.3 6585.3 6612.8 6617.2 6950.3 6968.9 6988.4 7006.4 7015.3 5181.8 5215.3 5230.4 5230.9 5242.4 6371.3 6447.5 6541.8 6561.7 6705.8 6109.2 6258.6 6291.7 6336.4 6399.7 6295.7 6323.7 6376.2 6394.2 6394.2 6290.5 6293.7 6322.3 6373.2 6416.8 6336.5 6357.9 6398.8 6474.4 6492.4 6252.2 6268.3 6269.6 6294.4 6345.9 13:37:08 INFO - PID 11705 | 13:37:08 INFO - PID 11705 | [#5] yui.html Cycles:180 Average:29346.05 Median:19733.65 stddev:43531.04 (220.6%) stddev-sans-first:43601.05 13:37:08 INFO - PID 11705 | Values: 979.8 1010.4 1031.4 1033.1 1042.6 20788.5 21080.5 21157.0 21253.0 21326.6 18922.0 19002.8 20387.6 20562.9 20693.0 1068.3 1084.1 1084.2 1084.2 1084.3 1070.9 1113.3 1114.9 1115.7 1116.4 1169.7 1190.3 1190.7 1191.4 1191.8 1177.9 1180.1 1181.1 1185.2 1185.7 859.4 867.1 868.2 871.4 871.6 21424.6 21950.6 22205.8 22293.3 22322.7 23514.9 23589.8 23998.3 24079.0 24081.8 17881.6 17959.8 17966.6 18021.3 18132.3 3995.8 4018.0 4062.8 4071.3 4073.8 165488.0 169356.0 170904.0 171338.0 172664.1 18034.3 18313.1 18379.8 18382.3 18398.7 34303.5 34863.1 34894.0 34990.3 35023.3 8308.6 8490.7 8633.7 8646.0 8652.9 4188.8 4257.9 4258.5 4264.1 4286.8 6192.2 6251.4 6290.0 6314.8 6330.8 1158.0 1173.7 1182.3 1190.9 1194.1 736.1 747.2 751.2 759.6 775.3 13124.2 13246.7 13388.3 14007.1 14358.9 716.3 717.4 717.6 724.2 727.8 5881.7 5903.1 6071.0 6073.2 6076.0 150553.0 152964.0 154111.0 155572.0 156308.2 128045.0 128947.0 129674.0 130065.0 133584.0 115122.4 116284.0 116982.0 118271.0 120649.4 13385.3 13971.9 14018.2 14068.4 14116.7 57509.7 57615.5 58129.7 58311.4 58924.4 71760.3 72245.6 72804.2 74246.6 75055.0 20578.7 20773.8 20795.5 20959.0 21034.0 20898.4 21553.1 21602.8 21618.6 21695.2 20631.5 20809.0 20849.3 20862.4 20893.6 18815.2 18818.9 19012.6 19062.2 19079.7 18345.7 18414.2 18582.1 18597.3 18991.6 14094.4 14616.0 14695.7 14757.4 14782.6 14526.9 14679.3 14689.9 14837.3 14906.2 13:37:08 INFO - PID 11705 | -------- Summary: end -------- 13:37:08 INFO - PID 11705 | 13:37:09 INFO - TEST-INFO | 11705: exit 0 13:37:09 INFO - TEST-OK | dromaeo_css | took 1105727ms 13:37:09 INFO - TEST-START | kraken 13:37:09 INFO - Initialising browser for kraken test... 13:37:09 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:38438/getInfo.html -profile /tmp/tmpUmB7Zn/profile 13:37:09 INFO - TEST-INFO | started process 12064 (/builds/slave/test/build/application/firefox/firefox http://localhost:38438/getInfo.html) 13:37:14 INFO - TEST-INFO | 12064: exit 0 13:37:14 INFO - Browser initialized. 13:37:14 INFO - Running cycle 1/1 for kraken test... 13:37:14 INFO - Using env: {'DISPLAY': ':0', 13:37:14 INFO - 'HOME': '/home/cltbld', 13:37:14 INFO - 'JSGC_DISABLE_POISONING': '1', 13:37:14 INFO - 'LANG': 'en_US.UTF-8', 13:37:14 INFO - 'LANGUAGE': 'en_US:en', 13:37:14 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 13:37:14 INFO - 'LOGNAME': 'cltbld', 13:37:14 INFO - 'MAIL': '/var/mail/cltbld', 13:37:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:37:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:37:14 INFO - 'MOZ_CRASHREPORTER': '1', 13:37:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:37:14 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 13:37:14 INFO - 'MOZ_NO_REMOTE': '1', 13:37:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:37:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:37:14 INFO - 'NO_EM_RESTART': '1', 13:37:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:37:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:37:14 INFO - 'PWD': '/builds/slave/test', 13:37:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:37:14 INFO - 'RUST_BACKTRACE': 'full', 13:37:14 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 13:37:14 INFO - 'SHELL': '/bin/bash', 13:37:14 INFO - 'SHLVL': '1', 13:37:14 INFO - 'TERM': 'linux', 13:37:14 INFO - 'TMOUT': '86400', 13:37:14 INFO - 'USER': 'cltbld', 13:37:14 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1508357863.551163-558148248', 13:37:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:37:14 INFO - '_': '/tools/buildbot/bin/python'} 13:37:14 INFO - TEST-INFO | started process 12294 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUmB7Zn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 13:37:14 INFO - PID 12294 | 13:37:14 INFO - PID 12294 | (/builds/slave/test/build/application/firefox/firefox:12342): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 13:37:14 INFO - PID 12294 | 13:37:25 INFO - PID 12294 | RSS: Main: 143212544 13:37:25 INFO - PID 12294 | 13:37:27 INFO - PID 12294 | Cycle 1(1): loaded http://localhost:38438/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38438/tests/kraken/driver.html?testName=audio-beat-detection) 13:37:28 INFO - PID 12294 | RSS: Main: 148705280 13:37:28 INFO - PID 12294 | 13:37:31 INFO - PID 12294 | Cycle 1(1): loaded http://localhost:38438/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38438/tests/kraken/driver.html?testName=audio-dft) 13:37:31 INFO - PID 12294 | RSS: Main: 149491712 13:37:31 INFO - PID 12294 | 13:37:34 INFO - PID 12294 | Cycle 1(1): loaded http://localhost:38438/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38438/tests/kraken/driver.html?testName=audio-fft) 13:37:35 INFO - PID 12294 | RSS: Main: 150999040 13:37:35 INFO - PID 12294 | 13:37:37 INFO - PID 12294 | Cycle 1(1): loaded http://localhost:38438/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38438/tests/kraken/driver.html?testName=audio-oscillator) 13:37:37 INFO - PID 12294 | RSS: Main: 151154688 13:37:37 INFO - PID 12294 | 13:37:39 INFO - PID 12294 | Cycle 1(1): loaded http://localhost:38438/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38438/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:37:40 INFO - PID 12294 | RSS: Main: 151142400 13:37:40 INFO - PID 12294 | 13:37:43 INFO - PID 12294 | Cycle 1(1): loaded http://localhost:38438/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38438/tests/kraken/driver.html?testName=imaging-darkroom) 13:37:44 INFO - PID 12294 | RSS: Main: 151310336 13:37:44 INFO - PID 12294 | 13:37:47 INFO - PID 12294 | Cycle 1(1): loaded http://localhost:38438/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38438/tests/kraken/driver.html?testName=imaging-desaturate) 13:37:48 INFO - PID 12294 | RSS: Main: 152002560 13:37:48 INFO - PID 12294 | 13:37:51 INFO - PID 12294 | Cycle 1(1): loaded http://localhost:38438/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38438/tests/kraken/driver.html?testName=json-parse-financial) 13:37:51 INFO - PID 12294 | RSS: Main: 153759744 13:37:51 INFO - PID 12294 | 13:37:53 INFO - PID 12294 | Cycle 1(1): loaded http://localhost:38438/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38438/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:37:53 INFO - PID 12294 | RSS: Main: 153161728 13:37:53 INFO - PID 12294 | 13:37:55 INFO - PID 12294 | Cycle 1(1): loaded http://localhost:38438/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38438/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:37:55 INFO - PID 12294 | RSS: Main: 153616384 13:37:55 INFO - PID 12294 | 13:37:57 INFO - PID 12294 | Cycle 1(1): loaded http://localhost:38438/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38438/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:37:58 INFO - PID 12294 | RSS: Main: 150392832 13:37:58 INFO - PID 12294 | 13:38:00 INFO - PID 12294 | Cycle 1(1): loaded http://localhost:38438/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38438/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:38:01 INFO - PID 12294 | RSS: Main: 150347776 13:38:01 INFO - PID 12294 | 13:38:04 INFO - PID 12294 | Cycle 1(1): loaded http://localhost:38438/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38438/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:38:04 INFO - PID 12294 | RSS: Main: 150450176 13:38:04 INFO - PID 12294 | 13:38:06 INFO - PID 12294 | Cycle 1(1): loaded http://localhost:38438/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38438/tests/kraken/driver.html?testName=ai-astar) 13:38:06 INFO - PID 12294 | RSS: Main: 152260608 13:38:06 INFO - PID 12294 | 13:38:06 INFO - PID 12294 | __start_tp_report 13:38:06 INFO - PID 12294 | _x_x_mozilla_page_load 13:38:06 INFO - PID 12294 | _x_x_mozilla_page_load_details 13:38:06 INFO - PID 12294 | |i|pagename|runs| 13:38:06 INFO - PID 12294 | |0;ai-astar;106;105;104;104;104;107;106;105;105;105 13:38:06 INFO - PID 12294 | |1;audio-beat-detection;111;111;111;110;113;109;112;113;115;115 13:38:06 INFO - PID 12294 | |2;audio-dft;163;163;163;163;164;164;163;165;163;163 13:38:06 INFO - PID 12294 | |3;audio-fft;74;73;75;72;72;74;73;74;73;72 13:38:06 INFO - PID 12294 | |4;audio-oscillator;77;78;78;76;78;77;77;123;77;77 13:38:06 INFO - PID 12294 | |5;imaging-gaussian-blur;114;114;114;114;115;110;114;114;113;114 13:38:06 INFO - PID 12294 | |6;imaging-darkroom;149;149;148;153;150;151;149;151;150;149 13:38:06 INFO - PID 12294 | |7;imaging-desaturate;94;93;94;94;94;94;94;94;95;93 13:38:06 INFO - PID 12294 | |8;json-parse-financial;42;42;43;44;43;43;43;43;43;44 13:38:06 INFO - PID 12294 | |9;json-stringify-tinderbox;45;46;46;47;46;45;46;46;46;46 13:38:06 INFO - PID 12294 | |10;stanford-crypto-aes;69;70;71;69;69;69;80;74;70;70 13:38:06 INFO - PID 12294 | |11;stanford-crypto-ccm;102;112;107;104;105;105;104;104;106;102 13:38:06 INFO - PID 12294 | |12;stanford-crypto-pbkdf2;150;157;154;154;157;147;155;156;150;148 13:38:06 INFO - PID 12294 | |13;stanford-crypto-sha256-iterative;57;59;59;60;58;57;57;61;58;61 13:38:06 INFO - PID 12294 | __end_tp_report 13:38:06 INFO - PID 12294 | __start_cc_report 13:38:06 INFO - PID 12294 | _x_x_mozilla_cycle_collect,689 13:38:06 INFO - PID 12294 | __end_cc_report 13:38:06 INFO - PID 12294 | __startTimestamp1508359086754__endTimestamp 13:38:06 INFO - PID 12294 | 13:38:06 INFO - PID 12294 | ------- Summary: start ------- 13:38:06 INFO - PID 12294 | Number of tests: 14 13:38:06 INFO - PID 12294 | 13:38:06 INFO - PID 12294 | [#0] ai-astar Cycles:10 Average:105.10 Median:105.00 stddev:0.99 (0.9%) stddev-sans-first:1.00 13:38:06 INFO - PID 12294 | Values: 106.0 105.0 104.0 104.0 104.0 107.0 106.0 105.0 105.0 105.0 13:38:06 INFO - PID 12294 | 13:38:06 INFO - PID 12294 | [#1] audio-beat-detection Cycles:10 Average:112.00 Median:112.50 stddev:2.00 (1.8%) stddev-sans-first:2.09 13:38:06 INFO - PID 12294 | Values: 111.0 111.0 111.0 110.0 113.0 109.0 112.0 113.0 115.0 115.0 13:38:06 INFO - PID 12294 | 13:38:06 INFO - PID 12294 | [#2] audio-dft Cycles:10 Average:163.40 Median:163.00 stddev:0.70 (0.4%) stddev-sans-first:0.73 13:38:06 INFO - PID 12294 | Values: 163.0 163.0 163.0 163.0 164.0 164.0 163.0 165.0 163.0 163.0 13:38:06 INFO - PID 12294 | 13:38:06 INFO - PID 12294 | [#3] audio-fft Cycles:10 Average:73.20 Median:73.50 stddev:1.03 (1.4%) stddev-sans-first:1.05 13:38:06 INFO - PID 12294 | Values: 74.0 73.0 75.0 72.0 72.0 74.0 73.0 74.0 73.0 72.0 13:38:06 INFO - PID 12294 | 13:38:06 INFO - PID 12294 | [#4] audio-oscillator Cycles:10 Average:81.80 Median:77.00 stddev:14.49 (18.8%) stddev-sans-first:15.26 13:38:06 INFO - PID 12294 | Values: 77.0 78.0 78.0 76.0 78.0 77.0 77.0 123.0 77.0 77.0 13:38:06 INFO - PID 12294 | 13:38:06 INFO - PID 12294 | [#5] imaging-gaussian-blur Cycles:10 Average:113.60 Median:114.00 stddev:1.35 (1.2%) stddev-sans-first:1.42 13:38:06 INFO - PID 12294 | Values: 114.0 114.0 114.0 114.0 115.0 110.0 114.0 114.0 113.0 114.0 13:38:06 INFO - PID 12294 | 13:38:06 INFO - PID 12294 | [#6] imaging-darkroom Cycles:10 Average:149.90 Median:150.00 stddev:1.45 (1.0%) stddev-sans-first:1.50 13:38:06 INFO - PID 12294 | Values: 149.0 149.0 148.0 153.0 150.0 151.0 149.0 151.0 150.0 149.0 13:38:06 INFO - PID 12294 | 13:38:06 INFO - PID 12294 | [#7] imaging-desaturate Cycles:10 Average:93.90 Median:94.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 13:38:06 INFO - PID 12294 | Values: 94.0 93.0 94.0 94.0 94.0 94.0 94.0 94.0 95.0 93.0 13:38:06 INFO - PID 12294 | 13:38:06 INFO - PID 12294 | [#8] json-parse-financial Cycles:10 Average:43.00 Median:43.00 stddev:0.67 (1.6%) stddev-sans-first:0.60 13:38:06 INFO - PID 12294 | Values: 42.0 42.0 43.0 44.0 43.0 43.0 43.0 43.0 43.0 44.0 13:38:06 INFO - PID 12294 | 13:38:06 INFO - PID 12294 | [#9] json-stringify-tinderbox Cycles:10 Average:45.90 Median:46.00 stddev:0.57 (1.2%) stddev-sans-first:0.50 13:38:06 INFO - PID 12294 | Values: 45.0 46.0 46.0 47.0 46.0 45.0 46.0 46.0 46.0 46.0 13:38:06 INFO - PID 12294 | 13:38:06 INFO - PID 12294 | [#10] stanford-crypto-aes Cycles:10 Average:71.10 Median:70.00 stddev:3.48 (5.0%) stddev-sans-first:3.61 13:38:06 INFO - PID 12294 | Values: 69.0 70.0 71.0 69.0 69.0 69.0 80.0 74.0 70.0 70.0 13:38:06 INFO - PID 12294 | 13:38:06 INFO - PID 12294 | [#11] stanford-crypto-ccm Cycles:10 Average:105.10 Median:105.00 stddev:2.88 (2.7%) stddev-sans-first:2.83 13:38:06 INFO - PID 12294 | Values: 102.0 112.0 107.0 104.0 105.0 105.0 104.0 104.0 106.0 102.0 13:38:06 INFO - PID 12294 | 13:38:06 INFO - PID 12294 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.80 Median:154.50 stddev:3.74 (2.4%) stddev-sans-first:3.82 13:38:06 INFO - PID 12294 | Values: 150.0 157.0 154.0 154.0 157.0 147.0 155.0 156.0 150.0 148.0 13:38:06 INFO - PID 12294 | 13:38:06 INFO - PID 12294 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:58.70 Median:59.00 stddev:1.57 (2.7%) stddev-sans-first:1.54 13:38:06 INFO - PID 12294 | Values: 57.0 59.0 59.0 60.0 58.0 57.0 57.0 61.0 58.0 61.0 13:38:06 INFO - PID 12294 | -------- Summary: end -------- 13:38:06 INFO - PID 12294 | 13:38:07 INFO - PID 12294 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 13:38:07 INFO - TEST-INFO | 12294: exit 0 13:38:07 INFO - TEST-OK | kraken | took 58233ms 13:38:07 INFO - SUITE-END | took 1163s 13:38:07 INFO - Completed test suite (00:19:24) 13:38:07 INFO - javascript benchmark 13:38:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9360.007581154501, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3966.305896468118, 3981.3231750602395, 3992.960070399295, 4011.7793521356316, 4012.478377810882, 6312.747490100396, 6338.207724034496, 6358.491320694345, 6379.617222966619, 6430.710618022183, 6388.297287298405, 6402.359764023596, 6447.129637498936, 6475.255345635253, 6482.96758516208, 5744.195812586252, 5755.338136114358, 5805.332386775512, 5827.125931110346, 5846.356900740915, 5802.303723553179, 5810.854728631776, 5815.273090863642, 5836.445537673914, 5872.5889187756875, 5802.506786923117, 5835.4164583541515, 5840.3575606683235, 5863.882722345551, 5875.823725288227, 5673.716314184274, 5765.365809760902, 5816.0, 5819.505342045889, 5844.503217226541, 5630.380658127644, 5673.773049078032, 5702.714864256812, 5708.743106560215, 5734.0, 6265.498760099181, 6281.59169653971, 6323.7786677466065, 6342.365763423621, 6352.1742173517605, 6756.4932630052945, 6833.931660683379, 6844.623545704984, 6872.484563657746, 6877.828054298632, 6822.181338239443, 6822.624755638438, 6837.589744615289, 6900.723971041152, 6923.238443771181, 6172.382761723837, 6248.375162483715, 6308.211473565759, 6323.05154226865, 6367.363263673642, 7156.570605763567, 7173.5337203081635, 7196.172440169343, 7196.964015179995, 7199.0, 6800.965995170091, 6817.590944543244, 6820.0, 6874.931250687529, 6887.827804304932, 6837.384635382839, 6870.141232345957, 6933.375996160269, 6967.79096627102, 7067.89398159028, 6783.59298442095, 6845.452363810883, 6861.622610756356, 6875.965620171867, 6879.449644028466, 6754.18949726036, 6759.324067593299, 6857.828554286083, 6865.725370985205, 6884.242733299333, 5006.249062640633, 5068.189089745697, 5086.033653605803, 5088.1350170471105, 5097.6941383517105, 4596.724196548218, 4642.326862604903, 4651.046535460223, 4662.7668616569035, 4675.018246168274, 6383.170187875547, 6401.871962560723, 6444.7744328948265, 6493.8701225976165, 6496.902546461807, 6851.657417129124, 6855.691493882788, 6917.412019978257, 6917.654117294115, 6920.377166055079, 6480.125183100221, 6483.481321494269, 6512.804615861532, 6535.57518761279, 6536.24833144185, 5733.741981610838, 5743.569232307594, 5776.104703770922, 5785.4793068623185, 5814.796482123105, 7042.542234754725, 7226.096737907762, 7237.565746055254, 7328.853422931512, 7332.30343117403, 6795.864082718318, 6822.897656535255, 6856.691448884912, 6910.239873613999, 6928.7228510859, 7194.388476979515, 7254.492185546961, 7326.743563975236, 7348.375388091858, 7356.190819009797, 6848.863022739418, 6849.1096157499205, 6912.308769123048, 6927.618980956096, 6929.480288978246, 6849.31506849331, 6883.552569082994, 6887.690053947485, 6992.825179370557, 7016.964915175391, 6591.274959754327, 6634.734610615521, 6709.161354830646, 6712.516368943327, 6751.189857217166, 6598.3401659833635, 6645.0, 6680.298568650222, 6682.565633233824, 6702.497312701469, 6577.80266592003, 6586.176727909012, 6668.83327916806, 6669.966650166718, 6676.899846502403, 6501.2523559791225, 6530.8040758777315, 6569.0, 6679.265280819203, 6719.395254427125, 6467.482601391784, 6534.411902928759, 6540.672966351568, 6550.967245163934, 6569.408753212043], "value": 6325.219513785858, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [991.4002028772593, 1013.7820368620747, 1040.1886528507766, 1046.487221261582, 1049.3231865446787, 43707.78146109269, 46143.769281153545, 46576.06847863045, 46711.53288467114, 46794.766026169906, 43621.345679814825, 46823.765881170635, 47464.525354746445, 47483.0503389932, 47607.761961190234, 7497.962510187455, 7514.736984205554, 7530.359919406829, 7539.736109236151, 7548.5093468924615, 7759.728409505668, 7864.488808227476, 7878.330341920943, 7898.210178982114, 7915.1689072647405, 7844.254795794419, 7935.285824275814, 7936.920630793705, 7938.563379014152, 7956.602169891511, 7886.526808391515, 7926.28663420292, 7939.4839335443585, 7943.761687149395, 7945.721899733539, 8061.274485296293, 8093.676252949875, 8097.716579919675, 8110.148434414361, 8113.269805717455, 42579.57420425818, 42933.78533107346, 43001.35497967533, 43034.56965430337, 43069.35395969063, 3813.637704418076, 3868.303705333039, 3870.767753934773, 3873.786941718204, 3875.5155605549307, 34904.82547587271, 34940.126496837525, 35175.648243517746, 35358.292834143176, 35359.4696079559, 5655.604107712462, 5676.290463692038, 5691.544676425876, 5692.146178073281, 5814.47669709724, 235550.0, 239809.0, 241239.0, 241618.0, 256947.99999999814, 57047.14429283564, 57114.714426428436, 57652.42347576554, 57741.4225857736, 57826.0, 59051.40948590545, 59179.70410147922, 59202.70398648065, 59220.0, 59451.405485945455, 17357.0, 17432.82567174312, 17503.0, 17507.824921750875, 17518.649627007642, 14138.717225655635, 14141.7979471744, 14153.787693184611, 14166.079204851652, 14172.787408188886, 15120.621984450258, 15286.464973725866, 15354.385824566893, 15376.615584610474, 15450.0, 5706.914396284059, 5825.50483208932, 5897.528197744256, 5980.611260268069, 6000.669963151981, 1089.4117176724637, 1110.7611863449235, 1131.7623299107115, 1133.5409159290336, 1143.4511434511314, 25984.836778538043, 26319.34201644974, 26343.0, 26583.73416265851, 26743.0, 1233.3956361383036, 1236.048242852998, 1236.6042866282703, 1240.7952687806592, 1254.7176885200756, 13702.314884255748, 13797.310134493235, 13858.792118118236, 13869.09850859691, 14121.85878141226, 289069.0, 294916.0, 298360.0, 300488.0, 306393.0, 64771.67614161899, 64790.35209647843, 65111.0, 65244.0, 65408.67295663586, 1522.2997421186158, 1528.4879565345511, 1539.1303913288955, 1550.9844901551292, 1589.5469791109479, 30415.847920760254, 31100.377992440477, 31378.0, 31661.0, 31915.202119947186, 43859.34210986774, 44015.0, 44051.118977619626, 44073.11853762971, 44416.777916110215, 255311.0, 255805.0, 256869.0, 257233.0, 257806.0, 37203.441948371335, 37792.62207377891, 38047.04882377962, 38108.42837357497, 38301.0, 48165.75917120392, 48939.265911010654, 49045.75477122592, 49259.75370123127, 49366.25950610815, 35206.47190292199, 35384.29231415409, 36422.27155456929, 36570.45144322784, 36572.45141322829, 35202.29595408026, 35636.821815890755, 35683.64316356907, 35841.82079089588, 36365.72719954895, 41559.58440415557, 41667.1666566673, 41807.790961045, 42154.36768448415, 42236.78881605572, 34458.82770586131, 34831.12922176966, 34961.30077398387, 35112.64887351094, 35454.8227258862, 25822.741772582034, 25853.482930341663, 26015.0, 26564.0, 26641.33396665099], "value": 19330.15472199297, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [621.6083867163686, 632.0, 638.1416994142876, 639.2201514152734, 644.2365796531111, 24039.278821635336, 24309.513809723838, 24824.255272341838, 24899.253022409335, 25603.359916002108, 27649.170524884234, 28100.859495702494, 28108.859455702743, 28129.29676758082, 28132.437351253015, 6773.4919881009, 6878.312168783132, 6915.827104322382, 6915.965420172917, 6939.895901561481, 6562.770303039395, 6931.896021559681, 6940.167179938415, 6961.269066747995, 6962.756303529378, 6873.690683919211, 6878.587284762905, 6910.101686780711, 6910.619915904624, 6930.896036559456, 6798.116244888133, 6864.279250678656, 6882.587044777304, 6888.827779305508, 6895.965520172417, 6389.648569328685, 6396.840078998062, 6418.19772528434, 6432.292447830735, 6434.163558737381, 31889.521657175163, 32029.83985080083, 32838.83580582106, 32870.178245543815, 32978.17554561131, 2355.5759963206615, 2408.6025805742033, 2414.9034038638433, 2416.891239894209, 2417.9965314394503, 21081.47296317589, 21426.46433839151, 21576.784232157635, 21615.243466478754, 21632.0, 2489.7136829264505, 2642.6036094585775, 2647.430802377479, 2650.9204723858315, 2657.694365147994, 146494.0, 153305.0, 160889.19555402265, 165684.17157914134, 166911.0, 16579.68406318741, 16965.830341696674, 16976.320947161974, 17066.31734730597, 17362.305507779547, 27371.31571710723, 27387.0, 27479.587806182924, 27524.311892202855, 27531.17406477809, 11575.536978520933, 11715.062794976382, 11739.23694959842, 11746.765064698659, 11787.941060294643, 10629.893701063045, 10634.096101831276, 10643.893561064446, 10731.731706707395, 10792.568297268179, 10486.26596138263, 10515.789684206273, 10713.303635263683, 10714.196435267386, 10758.300710453796, 2986.25343664084, 3005.0, 3037.9544306835414, 3058.128433396516, 3090.5673205751214, 1058.5977328615077, 1064.356064580933, 1066.7546464313252, 1069.9304545204536, 1077.283606401734, 22130.668039979413, 22553.66169507459, 22698.886505567367, 22797.202097926493, 22953.540929181323, 1153.7346410325672, 1159.3623507071077, 1173.3487914207697, 1177.1230433327225, 1182.5506307603227, 12305.50777968889, 12370.62888113358, 12537.122401431994, 12539.811902821464, 12546.874531254753, 596048.0, 613058.0, 616243.0, 648066.0, 652963.0, 134865.0, 136433.0, 138288.0, 139553.0, 140000.0, 1135.7558125003, 1277.8530468996184, 1293.8512071111943, 1297.7469393468184, 1309.4107651556837, 23137.537249254583, 23522.0, 23549.175778848345, 23790.881045595353, 23864.761352386253, 65644.38008688233, 65979.0, 66155.33844661491, 66209.33790662032, 67151.0, 79842.20157798348, 81240.0, 83186.0, 83571.16428835878, 84780.0, 16360.34558617642, 16538.09040502784, 16541.66916661684, 16582.66834663276, 16638.16809159513, 24657.63013554834, 25020.312741447404, 25552.361190970376, 25600.61599075978, 25768.226953191435, 20128.698069528677, 20262.59474810525, 20410.081546330155, 20544.486387840425, 20707.0, 18427.90786046115, 18493.72259416137, 18592.977386243347, 18903.810961890205, 19068.8093119067, 20905.37283881425, 20950.161993520698, 20959.37121886346, 21054.894725526276, 21256.25603103884, 16238.269277882287, 16301.347946082498, 16343.0, 16394.426195083113, 16571.0, 19841.206351746347, 20090.29683961113, 20130.295439660127, 20493.38519844407, 20836.895815520824], "value": 13474.251106369691, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1446.2190417174725, 1468.552091612058, 1488.2558720639681, 1500.1074360755347, 1504.774283857422, 17790.73313900291, 18518.722219166724, 18524.629507409845, 18544.165512551936, 18544.701870869045, 18116.547086322847, 18123.45629631113, 18197.636047279047, 18229.0885455727, 18231.908840455813, 3088.289693370526, 3126.40598286326, 3148.2129467632976, 3151.763617728668, 3164.351307981858, 3033.8179709217516, 3087.783855130142, 3103.3948380065895, 3105.1305634422283, 3105.2081719161583, 3056.0373482353098, 3066.0955018269665, 3078.9230269243335, 3079.214800225939, 3080.3531258435755, 2927.838968856712, 2936.6916473770266, 2953.1583498702876, 2953.8479992802822, 2953.911382658502, 2859.7140285971445, 2872.3680790226117, 2877.49643812332, 2886.7401933825845, 2888.638920134983, 17003.149842507948, 17199.398021069326, 17316.56708582283, 17353.913230433893, 17385.1307434629, 8864.645414183426, 9196.218321442686, 9198.494082825442, 9199.678011269574, 9204.171624553823, 6040.184575082351, 6153.692315384257, 6254.843628909313, 6311.147995020659, 6312.116303717483, 2151.3868547464053, 2181.9236326728646, 2211.458192742772, 2264.852784568998, 2276.2147059264526, 30157.436617887506, 31114.844425777952, 32597.51103733422, 33549.16127096842, 33680.32639347224, 8174.38692098095, 8280.254777070093, 8292.17078292166, 8532.104129066358, 8556.786080347916, 25039.12363067284, 25042.248732538053, 25068.122615708362, 25133.87433062823, 25148.74851251464, 9642.614295428104, 9717.514124293757, 9721.611135554498, 9770.706878793506, 9788.363756355957, 8416.4950102994, 8425.157484251526, 8601.31189504838, 8650.178233067974, 8681.262092722063, 6496.447801936888, 6508.088867558546, 6521.771737989147, 6560.507961902877, 6637.402633762985, 1948.9925376861854, 1949.132635977005, 1957.471482699663, 1964.72493850861, 1976.6244413561378, 956.5791051937125, 969.8060387922444, 969.8787651543557, 974.4348277998744, 981.8183636027358, 8719.738407847775, 9019.864702029476, 9028.63885444588, 9080.0, 9094.226990705863, 805.9194080592011, 818.5088946632093, 820.2699597358355, 824.7690646618956, 825.7398919340388, 4919.163742163841, 4973.278874563241, 4979.377577802775, 4995.825146119869, 5001.549860512571, 25250.747492525206, 26658.333541661224, 26727.732722672914, 26878.731212688013, 26978.055768048023, 26429.207123786317, 26550.734492654825, 26719.866400667874, 26731.33171670724, 27112.0, 12490.812637810259, 12513.249205047727, 12533.623991280276, 12589.24464532131, 12589.622311330491, 9079.909200907907, 9183.77040573991, 9221.677241296522, 9257.814843702954, 9312.906870931474, 21878.562428751018, 22332.88833555822, 22431.77568224297, 22531.324060277562, 22664.320070397913, 23330.300090997298, 23776.88111559431, 23924.401889952194, 24000.51998960046, 24271.271861844172, 14186.645333866736, 14274.857251427768, 14408.567742967727, 14413.279336032947, 14436.783448248074, 16212.10833404174, 16217.51347459578, 16294.266757995681, 16499.010059396474, 16565.503034908972, 13066.934665326613, 13069.738605228033, 13103.803442948554, 13268.071235013456, 13299.401526931504, 12796.808047879103, 12992.675183120498, 13173.802392964304, 13307.46770129184, 13313.46746130144, 11436.085113190758, 11677.76644467123, 11756.588519402121, 11759.0, 11760.588379407021, 8248.711295104642, 8371.079181289932, 8455.365847561581, 8548.658053677784, 8599.699010534601, 8005.759827205193, 8089.150639182801, 8195.549244791355, 8208.958955205186, 8243.917560824315], "value": 7740.509061782905, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [550.3863192540318, 582.3303201318481, 595.9284885813697, 596.4542443664046, 601.8645804693945, 6162.59943103698, 6181.752729890799, 6187.627742880124, 6198.814035578928, 6203.379662033794, 6070.817875463732, 6121.173641558388, 6122.326544080148, 6140.8464788380315, 6148.631082135075, 5016.570277470922, 5043.226225575937, 5103.387593488777, 5104.719240441774, 5107.872303192413, 4816.686915350491, 4916.139675556781, 5045.72028181683, 5125.615578831584, 5131.640785145041, 4917.385326834145, 4940.876478088041, 4962.875928101808, 4974.477679843619, 4978.900421991558, 4878.0975519529, 4907.9263811042865, 4942.851714448572, 4945.703257804544, 4959.330490383788, 4477.6417886569, 4517.909641807146, 4522.525134860825, 4536.614387777043, 4540.931886021713, 6034.728437220336, 6055.2430946131735, 6065.60573562717, 6081.756729730805, 6081.939180608226, 5778.566607504454, 5796.304443466811, 5816.767329306823, 5828.242328497311, 5830.504407125357, 6450.677466126722, 6466.612003279818, 6498.577592456475, 6505.837354066139, 6511.186101737283, 4806.110869489155, 4985.675931064506, 4989.301497790312, 4998.500149985009, 5017.77064619167, 6532.836679083013, 6686.866262674719, 6767.830804229884, 6772.458203343721, 6790.898136527907, 5104.489551044866, 5104.617153713486, 5175.896482070338, 5192.273081768555, 5199.428062913076, 5205.375354957429, 5245.423003469616, 5256.894862102737, 5258.3689957204615, 5284.0, 5725.625849796019, 5744.626599271034, 5767.452092051332, 5815.255423373056, 5817.156512305776, 6496.083655321691, 6533.738650454024, 6546.214454265423, 6546.8363290918105, 6613.86772264552, 1790.409164975581, 1792.8207179281967, 1804.927802887896, 1813.909304534768, 1815.3464752689022, 1253.7587788089909, 1301.466398776497, 1306.5623016289649, 1310.0, 1311.9803202951964, 5605.8598535036135, 6155.446009859044, 6179.0535981165785, 6202.255729312511, 6217.6891155442045, 6483.675816209265, 6499.5775274607, 6531.354801305479, 6557.344265573404, 6574.868502630016, 6117.449429551273, 6137.9079313810325, 6148.907766383508, 6171.0, 6188.0, 3469.739769517246, 3478.1826270826336, 3483.512308276843, 3503.211777350076, 3512.438009918401, 6882.139732533434, 6884.139482564679, 6904.997550710338, 6914.446844252448, 7001.544899581511, 6609.966950165219, 6639.468842492685, 6693.397594216543, 6729.764458243938, 6758.560693554903, 6769.0, 6838.48711346651, 6891.3797758202, 6898.793036208922, 6902.654867256517, 6566.0, 6600.207975043026, 6603.636799976048, 6612.603243805194, 6621.370969757865, 6548.692910080379, 6570.342965703582, 6585.3085426029575, 6612.801615951529, 6617.205935287604, 6950.304969503211, 6968.930310696828, 6988.37104660583, 7006.369426751617, 7015.298470152944, 5181.792728290826, 5215.322008138917, 5230.398504172069, 5230.921536177037, 5242.449542797951, 6371.331010243857, 6447.451966582893, 6541.8037458874405, 6561.704723287368, 6705.765298214539, 6109.175261339662, 6258.593191442542, 6291.7035282122615, 6336.366363363627, 6399.7440102395385, 6295.748170073146, 6323.652199129092, 6376.234851817811, 6394.200724909387, 6394.23269207698, 6290.495816160859, 6293.716782744879, 6322.26986078216, 6373.171487706569, 6416.7754128605275, 6336.493080553452, 6357.8728425432155, 6398.776042838478, 6474.446132928158, 6492.38322359394, 6252.187215661935, 6268.27914789805, 6269.592476489013, 6294.402031806971, 6345.8730825384155], "value": 5111.9174819843965, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [979.8481235408514, 1010.3887148275292, 1031.3708637730988, 1033.0650761061238, 1042.5933885784546, 20788.480287992807, 21080.472988175265, 21157.0, 21253.0, 21326.573468530638, 18922.0, 19002.80997190028, 20387.59224815503, 20562.89718551405, 20693.0, 1068.2895874243638, 1084.138110202387, 1084.1868598551087, 1084.230196560439, 1084.2735367303926, 1070.8929107089268, 1113.2541197397763, 1114.8717897441777, 1115.7043383503378, 1116.4250411038322, 1169.6958790714432, 1190.2917763930448, 1190.672565044611, 1191.410251925298, 1191.8212268159803, 1177.8881006304387, 1180.1267062373868, 1181.1141643767176, 1185.2118341303023, 1185.6857932647856, 859.4456575508824, 867.1155421470128, 868.2229404682837, 871.4422769427572, 871.6382701179003, 21424.571508569898, 21950.560988780293, 22205.77794222053, 22293.331200064025, 22322.665160022614, 23514.882425587763, 23589.764102358928, 23998.280051598307, 24079.0, 24081.759182408303, 17881.552961175945, 17959.820401795947, 17966.550836229067, 18021.27914883416, 18132.274709011625, 3995.840166393341, 4017.97991010046, 4062.8171732272117, 4071.2671719090554, 4073.816678249486, 165488.0, 169356.0, 170904.0, 171338.0, 172664.13667931705, 18034.27862885496, 18313.084345782656, 18379.81620183808, 18382.264709411473, 18398.724019139725, 34303.4854477183, 34863.12842178915, 34894.0, 34990.30019399649, 35023.29953400969, 8308.626111824982, 8490.702825401082, 8633.69782057625, 8646.0, 8652.913470865336, 4188.790560471964, 4257.936130958038, 4258.53156152823, 4264.104538046983, 4286.807093680792, 6192.164057852222, 6251.437370636664, 6289.96855015722, 6314.778982735582, 6330.8100756977365, 1157.9826302605468, 1173.6655053309767, 1182.3142577305143, 1190.9166358355005, 1194.0865238092865, 736.0872518077653, 747.196763479262, 751.1887161865172, 759.6239861268707, 775.3487070860391, 13124.212547247196, 13246.73506529864, 13388.263645499592, 14007.098394125474, 14358.856411435752, 716.3230746944192, 717.3615482220828, 717.6340066566089, 724.2069933422998, 727.752564128199, 5881.735321910524, 5903.1145328200255, 6071.0, 6073.240844894388, 6075.969620151871, 150553.0, 152964.0, 154111.0, 155572.0, 156308.21845890925, 128045.0, 128947.0, 129674.0, 130065.0, 133584.0, 115122.42438787753, 116284.04484497788, 116982.0, 118271.0, 120649.39675301567, 13385.330733463483, 13971.860281397056, 14018.158910465405, 14068.437262509386, 14116.717665646423, 57509.712451437474, 57615.50998370185, 58129.709351454665, 58311.416885832296, 58924.41075589189, 71760.28239717535, 72245.63877180581, 72804.18856505923, 74246.62876685798, 75055.0, 20578.691319630518, 20773.79226207779, 20795.480112997295, 20959.0, 21034.0, 20898.37304880856, 21553.137874484844, 21602.783972160076, 21618.567628647026, 21695.240666576596, 20631.484212894797, 20809.0, 20849.270275540282, 20862.374128776162, 20893.582128357044, 18815.15331810099, 18818.905905470387, 19012.619747604695, 19062.237510499424, 19079.71380429267, 18345.72481412753, 18414.17136228846, 18582.070896455392, 18597.256109755457, 18991.620167596848, 14094.36575354132, 14616.0, 14695.691247690678, 14757.409703611735, 14782.556523304318, 14526.927365363106, 14679.266036698336, 14689.92655036718, 14837.33232004584, 14906.180160090866], "value": 10314.784250533283, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1369.4999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 105.0, 104.0, 104.0, 104.0, 107.0, 106.0, 105.0, 105.0, 105.0], "value": 105.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 111.0, 111.0, 110.0, 113.0, 109.0, 112.0, 113.0, 115.0, 115.0], "value": 112.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 163.0, 163.0, 164.0, 164.0, 163.0, 165.0, 163.0, 163.0], "value": 163.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 75.0, 72.0, 72.0, 74.0, 73.0, 74.0, 73.0, 72.0], "value": 73.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 78.0, 76.0, 78.0, 77.0, 77.0, 123.0, 77.0, 77.0], "value": 81.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 115.0, 110.0, 114.0, 114.0, 113.0, 114.0], "value": 113.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 148.0, 153.0, 150.0, 151.0, 149.0, 151.0, 150.0, 149.0], "value": 149.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 93.0], "value": 93.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [42.0, 42.0, 43.0, 44.0, 43.0, 43.0, 43.0, 43.0, 43.0, 44.0], "value": 43.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [45.0, 46.0, 46.0, 47.0, 46.0, 45.0, 46.0, 46.0, 46.0, 46.0], "value": 45.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 71.0, 69.0, 69.0, 69.0, 80.0, 74.0, 70.0, 70.0], "value": 71.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 107.0, 104.0, 105.0, 105.0, 104.0, 104.0, 106.0, 102.0], "value": 105.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 157.0, 154.0, 154.0, 157.0, 147.0, 155.0, 156.0, 150.0, 148.0], "value": 152.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 59.0, 59.0, 60.0, 58.0, 57.0, 57.0, 61.0, 58.0, 61.0], "value": 58.7, "unit": "score"}]}]} 13:38:07 INFO - Return code: 0 13:38:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:38:07 INFO - # TBPL SUCCESS # 13:38:07 INFO - Running post-action listener: _package_coverage_data 13:38:07 INFO - Running post-action listener: _resource_record_post_action 13:38:07 INFO - [mozharness: 2017-10-18 20:38:07.539920Z] Finished run-tests step (success) 13:38:07 INFO - Running post-run listener: _resource_record_post_run 13:38:07 INFO - Total resource usage - Wall time: 1179s; CPU: 13.0%; Read bytes: 4096; Write bytes: 281706496; Read time: 8; Write time: 185844 13:38:07 INFO - TinderboxPrint: CPU usage
13.1% 13:38:07 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 13:38:07 INFO - TinderboxPrint: I/O write bytes / time
281,706,496 / 185,844 13:38:07 INFO - TinderboxPrint: CPU idle
8,171.6 (86.9%) 13:38:07 INFO - TinderboxPrint: CPU user
1,177.3 (12.5%) 13:38:07 INFO - TinderboxPrint: Swap in / out
0 / 0 13:38:07 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 9330688; Read time: 0; Write time: 556 13:38:07 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 13:38:07 INFO - run-tests - Wall time: 1165s; CPU: 13.0%; Read bytes: 4096; Write bytes: 271966208; Read time: 8; Write time: 185260 13:38:08 INFO - Running post-run listener: _upload_blobber_files 13:38:08 INFO - Blob upload gear active. 13:38:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:38:08 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 13:38:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:38:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:38:08 INFO - (blobuploader) - INFO - Open directory for files ... 13:38:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 13:38:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:38:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:38:09 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 13:38:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:38:09 INFO - (blobuploader) - INFO - Done attempting. 13:38:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:38:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:38:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:38:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:38:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:38:16 INFO - (blobuploader) - INFO - Done attempting. 13:38:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:38:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:38:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:38:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:38:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:38:17 INFO - (blobuploader) - INFO - Done attempting. 13:38:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:38:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:38:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:38:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:38:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:38:20 INFO - (blobuploader) - INFO - Done attempting. 13:38:20 INFO - (blobuploader) - INFO - Iteration through files over. 13:38:20 INFO - Return code: 0 13:38:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:38:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:38:20 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/25f50ca63ee2ccf43e232374dae80fc0d142c21f0bdcd1c889cae2c25afd75f28f27df78050902f6c23e72d9a0115cf52d7d42fbd763d81af87553145aa0407a", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/c6c01f473c5f4d4071b1db0f1ca56708bce85298aa92c549a96675f6be45d05962998cb711cb88d5a91e1af9c33fe86fb36ed822fb4f0f1bbadfd4bf6e66fb6b", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/cae859fffc4c5e6ef27fa1ffa7336c38c779c340466752bca9ca6672755ee5e4353935de5666032aecb538e05b12e57b7de29c0248ffa2f35e922b7570aecf79", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/820a6af16705c3689b4fb79bd2bf895c9701a879aca5d73ecc6a37bbd4b615bf557fed31ff75f9f5cde83c190893c6df3e0b23acf98f9596876425dfaffc29c2"} 13:38:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:38:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:38:20 INFO - Contents: 13:38:20 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/25f50ca63ee2ccf43e232374dae80fc0d142c21f0bdcd1c889cae2c25afd75f28f27df78050902f6c23e72d9a0115cf52d7d42fbd763d81af87553145aa0407a", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/c6c01f473c5f4d4071b1db0f1ca56708bce85298aa92c549a96675f6be45d05962998cb711cb88d5a91e1af9c33fe86fb36ed822fb4f0f1bbadfd4bf6e66fb6b", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/cae859fffc4c5e6ef27fa1ffa7336c38c779c340466752bca9ca6672755ee5e4353935de5666032aecb538e05b12e57b7de29c0248ffa2f35e922b7570aecf79", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/820a6af16705c3689b4fb79bd2bf895c9701a879aca5d73ecc6a37bbd4b615bf557fed31ff75f9f5cde83c190893c6df3e0b23acf98f9596876425dfaffc29c2"} 13:38:20 INFO - Running post-run listener: copy_logs_to_upload_dir 13:38:20 INFO - Copying logs to upload dir... 13:38:20 INFO - mkdir: /builds/slave/test/build/upload/logs 13:38:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.277841 ========= master_lag: 0.08 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2017-10-18 13:38:20.920452) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-18 13:38:20.925035) ========= 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=1f5564757af27664ca02d71f000001b0-1508357863.551163-558148248 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/25f50ca63ee2ccf43e232374dae80fc0d142c21f0bdcd1c889cae2c25afd75f28f27df78050902f6c23e72d9a0115cf52d7d42fbd763d81af87553145aa0407a", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/c6c01f473c5f4d4071b1db0f1ca56708bce85298aa92c549a96675f6be45d05962998cb711cb88d5a91e1af9c33fe86fb36ed822fb4f0f1bbadfd4bf6e66fb6b", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/cae859fffc4c5e6ef27fa1ffa7336c38c779c340466752bca9ca6672755ee5e4353935de5666032aecb538e05b12e57b7de29c0248ffa2f35e922b7570aecf79", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/820a6af16705c3689b4fb79bd2bf895c9701a879aca5d73ecc6a37bbd4b615bf557fed31ff75f9f5cde83c190893c6df3e0b23acf98f9596876425dfaffc29c2"} build_url:https://queue.taskcluster.net/v1/task/DxSyuDGrTnqOFaD84cZ-Pg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011193 build_url: 'https://queue.taskcluster.net/v1/task/DxSyuDGrTnqOFaD84cZ-Pg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/25f50ca63ee2ccf43e232374dae80fc0d142c21f0bdcd1c889cae2c25afd75f28f27df78050902f6c23e72d9a0115cf52d7d42fbd763d81af87553145aa0407a", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/c6c01f473c5f4d4071b1db0f1ca56708bce85298aa92c549a96675f6be45d05962998cb711cb88d5a91e1af9c33fe86fb36ed822fb4f0f1bbadfd4bf6e66fb6b", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/cae859fffc4c5e6ef27fa1ffa7336c38c779c340466752bca9ca6672755ee5e4353935de5666032aecb538e05b12e57b7de29c0248ffa2f35e922b7570aecf79", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/820a6af16705c3689b4fb79bd2bf895c9701a879aca5d73ecc6a37bbd4b615bf557fed31ff75f9f5cde83c190893c6df3e0b23acf98f9596876425dfaffc29c2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-18 13:38:20.957440) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-18 13:38:20.957774) ========= 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=1f5564757af27664ca02d71f000001b0-1508357863.551163-558148248 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004542 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-18 13:38:21.036576) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-18 13:38:21.039914) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-18 13:38:21.040221) ========= ========= Total master_lag: 0.24 =========